builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-014 starttime: 1479829476.22 results: success (0) buildid: 20161122062350 builduid: dd212d26a75949458cc09d0d10e22904 revision: 39388a57920863c7487437a4571eb9186591e876 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 07:44:36.218059) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 07:44:36.218457) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 07:44:36.218739) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 07:44:36.253512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 07:44:36.253791) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-22 07:44:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-11-22 07:44:36 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.211424 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 07:44:36.479884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 07:44:36.480174) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019453 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 07:44:36.529066) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-22 07:44:36.529380) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 39388a57920863c7487437a4571eb9186591e876 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 39388a57920863c7487437a4571eb9186591e876 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-22 07:44:36,872 truncating revision to first 12 chars 2016-11-22 07:44:36,872 Setting DEBUG logging. 2016-11-22 07:44:36,872 attempt 1/10 2016-11-22 07:44:36,872 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/39388a579208?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-22 07:44:38,158 unpacking tar archive at: graphics-39388a579208/testing/mozharness/ program finished with exit code 0 elapsedTime=1.582317 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-22 07:44:38.124559) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 07:44:38.124868) ========= script_repo_revision: 39388a57920863c7487437a4571eb9186591e876 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 07:44:38.125259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 07:44:38.125822) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 07:44:38.134527) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-22 07:44:38.134802) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:44:38 INFO - MultiFileLogger online at 20161122 07:44:38 in /builds/slave/test 07:44:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 07:44:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:44:38 INFO - {'append_to_log': False, 07:44:38 INFO - 'base_work_dir': '/builds/slave/test', 07:44:38 INFO - 'blob_upload_branch': 'Graphics', 07:44:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:44:38 INFO - 'branch': 'Graphics', 07:44:38 INFO - 'buildbot_json_path': 'buildprops.json', 07:44:38 INFO - 'config_files': ('talos/linux_config.py',), 07:44:38 INFO - 'default_actions': ('clobber', 07:44:38 INFO - 'read-buildbot-config', 07:44:38 INFO - 'download-and-extract', 07:44:38 INFO - 'populate-webroot', 07:44:38 INFO - 'create-virtualenv', 07:44:38 INFO - 'install', 07:44:38 INFO - 'run-tests'), 07:44:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:44:38 INFO - 'download_minidump_stackwalk': True, 07:44:38 INFO - 'download_symbols': 'ondemand', 07:44:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:44:38 INFO - 'tooltool.py': '/tools/tooltool.py', 07:44:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:44:38 INFO - '/tools/misc-python/virtualenv.py')}, 07:44:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:44:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:44:38 INFO - 'installer_path': 'installer.exe', 07:44:38 INFO - 'log_level': 'info', 07:44:38 INFO - 'log_name': 'talos', 07:44:38 INFO - 'log_to_console': True, 07:44:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:44:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:44:38 INFO - 'opt_config_files': (), 07:44:38 INFO - 'pip_index': False, 07:44:38 INFO - 'sps_profile': False, 07:44:38 INFO - 'sps_profile_interval': 0, 07:44:38 INFO - 'suite': 'dromaeojs-e10s', 07:44:38 INFO - 'system_bits': '32', 07:44:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:44:38 INFO - 'title': 'talos-linux64-ix-014', 07:44:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:44:38 INFO - 'use_talos_json': True, 07:44:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:44:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:44:38 INFO - 'work_dir': 'build'} 07:44:38 INFO - [mozharness: 2016-11-22 15:44:38.580151Z] Running clobber step. 07:44:38 INFO - Running pre-action listener: _resource_record_pre_action 07:44:38 INFO - Running main action method: clobber 07:44:38 INFO - rmtree: /builds/slave/test/build 07:44:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:44:39 INFO - Running post-action listener: _resource_record_post_action 07:44:39 INFO - [mozharness: 2016-11-22 15:44:39.038243Z] Finished clobber step (success) 07:44:39 INFO - [mozharness: 2016-11-22 15:44:39.038344Z] Running read-buildbot-config step. 07:44:39 INFO - Running pre-action listener: _resource_record_pre_action 07:44:39 INFO - Running main action method: read_buildbot_config 07:44:39 INFO - Using buildbot properties: 07:44:39 INFO - { 07:44:39 INFO - "project": "", 07:44:39 INFO - "product": "firefox", 07:44:39 INFO - "script_repo_revision": "default", 07:44:39 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 07:44:39 INFO - "repository": "", 07:44:39 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 07:44:39 INFO - "buildid": "20161122062350", 07:44:39 INFO - "pgo_build": "False", 07:44:39 INFO - "basedir": "/builds/slave/test", 07:44:39 INFO - "buildnumber": 15, 07:44:39 INFO - "slavename": "talos-linux64-ix-014", 07:44:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:44:39 INFO - "platform": "ubuntu64_hw", 07:44:39 INFO - "scheduler": "tests-graphics-linux64-talos", 07:44:39 INFO - "branch": "graphics", 07:44:39 INFO - "repo_path": "projects/graphics", 07:44:39 INFO - "revision": "39388a57920863c7487437a4571eb9186591e876", 07:44:39 INFO - "stage_platform": "linux64", 07:44:39 INFO - "builduid": "dd212d26a75949458cc09d0d10e22904", 07:44:39 INFO - "slavebuilddir": "test" 07:44:39 INFO - } 07:44:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:44:39 INFO - Running post-action listener: _resource_record_post_action 07:44:39 INFO - [mozharness: 2016-11-22 15:44:39.040755Z] Finished read-buildbot-config step (success) 07:44:39 INFO - [mozharness: 2016-11-22 15:44:39.040844Z] Running download-and-extract step. 07:44:39 INFO - Running pre-action listener: _resource_record_pre_action 07:44:39 INFO - Running main action method: download_and_extract 07:44:39 INFO - mkdir: /builds/slave/test/build/tests 07:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:39 INFO - trying https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:44:39 INFO - Downloading https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:44:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:44:39 INFO - Downloaded 1361 bytes. 07:44:39 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:44:39 INFO - Using the following test package requirements: 07:44:39 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:44:39 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:44:39 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:44:39 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:39 INFO - u'jsshell-linux-x86_64.zip'], 07:44:39 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:44:39 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:44:39 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:44:39 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:44:39 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:44:39 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:44:39 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:44:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:44:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:44:39 INFO - Fetch https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:44:40 INFO - Http code: 200 07:44:40 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 07:44:40 INFO - x-amz-cf-id: 8423CaMDmEttIFsNwKyXmRT-oSZM-l2MsnKU3728q7Fy_yTjCDVVvg== 07:44:40 INFO - x-amz-version-id: aWbnjKxZ5PiCaIwx4dKNtrj7LRtAuUte 07:44:40 INFO - Expected file size: 20327684 07:44:40 INFO - Obtained file size: 20327684 07:44:44 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:44:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:44:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:44:44 INFO - Fetch https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:44:44 INFO - Http code: 200 07:44:44 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 07:44:44 INFO - x-amz-cf-id: mFxESsJ9pWBEFHPX8nlqL1CI264QBS2vKigp8Dj8XMk7lfCwjeEx_g== 07:44:44 INFO - x-amz-version-id: aWbnjKxZ5PiCaIwx4dKNtrj7LRtAuUte 07:44:45 INFO - Expected file size: 20327684 07:44:45 INFO - Obtained file size: 20327684 07:44:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:44:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:44:49 INFO - Fetch https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:44:50 INFO - Http code: 200 07:44:50 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 07:44:50 INFO - x-amz-cf-id: LhBjiZ8T2Lm3upmXxUNQMO5r2sSLGxXhU09Q7f4hQc80-_IIKlFLPA== 07:44:50 INFO - x-amz-version-id: ZPa9alCL5p01uFJbWWKbOx_j54G4dRA6 07:44:50 INFO - Expected file size: 14409392 07:44:50 INFO - Obtained file size: 14409392 07:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:50 INFO - trying https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:44:50 INFO - Downloading https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:44:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:44:51 INFO - Downloaded 55398994 bytes. 07:44:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:44:51 INFO - mkdir: /builds/slave/test/properties 07:44:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:44:51 INFO - Writing to file /builds/slave/test/properties/build_url 07:44:51 INFO - Contents: 07:44:51 INFO - build_url:https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:44:52 INFO - Running post-action listener: _resource_record_post_action 07:44:52 INFO - Running post-action listener: set_extra_try_arguments 07:44:52 INFO - [mozharness: 2016-11-22 15:44:52.534009Z] Finished download-and-extract step (success) 07:44:52 INFO - [mozharness: 2016-11-22 15:44:52.534235Z] Running populate-webroot step. 07:44:52 INFO - Running pre-action listener: _resource_record_pre_action 07:44:52 INFO - Running main action method: populate_webroot 07:44:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:44:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:44:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:44:52 INFO - '--tppagecycles', 07:44:52 INFO - '7'], 07:44:52 INFO - 'tests': ['tsvgm']}}, 07:44:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:44:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:44:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:44:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:44:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:44:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:44:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:44:52 INFO - 'talos_options': ['--disable-e10s'], 07:44:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:44:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:44:52 INFO - 'talos_options': ['--disable-e10s'], 07:44:52 INFO - 'tests': ['damp', 'tps']}, 07:44:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:44:52 INFO - 'tests': ['damp', 'tps']}, 07:44:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:44:52 INFO - 'tests': ['dromaeo_dom']}, 07:44:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:44:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:44:52 INFO - 'tests': ['basic_compositor_video']}, 07:44:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:44:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:44:52 INFO - 'tests': ['a11yr', 07:44:52 INFO - 'ts_paint', 07:44:52 INFO - 'tpaint', 07:44:52 INFO - 'sessionrestore', 07:44:52 INFO - 'sessionrestore_no_auto_restore', 07:44:52 INFO - 'tabpaint']}, 07:44:52 INFO - 'other-e10s': {'tests': ['a11yr', 07:44:52 INFO - 'ts_paint', 07:44:52 INFO - 'tpaint', 07:44:52 INFO - 'sessionrestore', 07:44:52 INFO - 'sessionrestore_no_auto_restore', 07:44:52 INFO - 'tabpaint']}, 07:44:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:44:52 INFO - 'ts_paint', 07:44:52 INFO - 'tpaint', 07:44:52 INFO - 'sessionrestore', 07:44:52 INFO - 'sessionrestore_no_auto_restore', 07:44:52 INFO - 'tabpaint']}, 07:44:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:44:52 INFO - 'ts_paint', 07:44:52 INFO - 'tpaint', 07:44:52 INFO - 'sessionrestore', 07:44:52 INFO - 'sessionrestore_no_auto_restore', 07:44:52 INFO - 'tabpaint']}, 07:44:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:44:52 INFO - 'tests': ['a11yr', 07:44:52 INFO - 'ts_paint', 07:44:52 INFO - 'tpaint', 07:44:52 INFO - 'sessionrestore', 07:44:52 INFO - 'sessionrestore_no_auto_restore', 07:44:52 INFO - 'tabpaint']}, 07:44:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:44:52 INFO - 'tests': ['a11yr', 07:44:52 INFO - 'ts_paint', 07:44:52 INFO - 'tpaint', 07:44:52 INFO - 'sessionrestore', 07:44:52 INFO - 'sessionrestore_no_auto_restore', 07:44:52 INFO - 'tabpaint']}, 07:44:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:44:52 INFO - 'tests': ['tsvgx', 07:44:52 INFO - 'tsvgr_opacity', 07:44:52 INFO - 'tart', 07:44:52 INFO - 'tscrollx', 07:44:52 INFO - 'cart']}, 07:44:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:44:52 INFO - 'tsvgr_opacity', 07:44:52 INFO - 'tart', 07:44:52 INFO - 'tscrollx', 07:44:52 INFO - 'cart']}, 07:44:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:44:52 INFO - 'talos_options': ['--disable-e10s'], 07:44:52 INFO - 'tests': ['tp5o']}, 07:44:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:44:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:44:52 INFO - 'talos_options': ['--disable-e10s', 07:44:52 INFO - '--xperf_path', 07:44:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:52 INFO - 'tests': ['tp5n']}, 07:44:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:44:52 INFO - 'talos_options': ['--xperf_path', 07:44:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:52 INFO - 'tests': ['tp5n']}}, 07:44:52 INFO - 'talos.zip': {'path': '', 07:44:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:44:52 INFO - Running post-action listener: _resource_record_post_action 07:44:52 INFO - [mozharness: 2016-11-22 15:44:52.553862Z] Finished populate-webroot step (success) 07:44:52 INFO - [mozharness: 2016-11-22 15:44:52.553949Z] Running create-virtualenv step. 07:44:52 INFO - Running pre-action listener: _resource_record_pre_action 07:44:52 INFO - Running main action method: create_virtualenv 07:44:52 INFO - Creating virtualenv /builds/slave/test/build/venv 07:44:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:44:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:44:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:44:52 INFO - Using real prefix '/usr' 07:44:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:44:53 INFO - Installing distribute.............................................................................................................................................................................................done. 07:44:55 INFO - Installing pip.................done. 07:44:55 INFO - Return code: 0 07:44:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:44:55 INFO - Reading from file tmpfile_stdout 07:44:55 INFO - Output received: 07:44:55 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:44:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7182fede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2838b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a62fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a64350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:44:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:44:55 INFO - Using env: {'DISPLAY': ':0', 07:44:55 INFO - 'HOME': '/home/cltbld', 07:44:55 INFO - 'LANG': 'en_US.UTF-8', 07:44:55 INFO - 'LANGUAGE': 'en_US:en', 07:44:55 INFO - 'LOGNAME': 'cltbld', 07:44:55 INFO - 'MAIL': '/var/mail/cltbld', 07:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:55 INFO - 'MOZ_NO_REMOTE': '1', 07:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:55 INFO - 'NO_EM_RESTART': '1', 07:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:55 INFO - 'PWD': '/builds/slave/test', 07:44:55 INFO - 'SHELL': '/bin/bash', 07:44:55 INFO - 'SHLVL': '1', 07:44:55 INFO - 'TERM': 'linux', 07:44:55 INFO - 'TMOUT': '86400', 07:44:55 INFO - 'USER': 'cltbld', 07:44:55 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 07:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:55 INFO - '_': '/tools/buildbot/bin/python'} 07:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:44:55 INFO - Cleaning up... 07:44:55 INFO - Return code: 0 07:44:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7182fede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2838b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a62fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a64350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:44:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:44:55 INFO - Using env: {'DISPLAY': ':0', 07:44:55 INFO - 'HOME': '/home/cltbld', 07:44:55 INFO - 'LANG': 'en_US.UTF-8', 07:44:55 INFO - 'LANGUAGE': 'en_US:en', 07:44:55 INFO - 'LOGNAME': 'cltbld', 07:44:55 INFO - 'MAIL': '/var/mail/cltbld', 07:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:55 INFO - 'MOZ_NO_REMOTE': '1', 07:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:55 INFO - 'NO_EM_RESTART': '1', 07:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:55 INFO - 'PWD': '/builds/slave/test', 07:44:55 INFO - 'SHELL': '/bin/bash', 07:44:55 INFO - 'SHLVL': '1', 07:44:55 INFO - 'TERM': 'linux', 07:44:55 INFO - 'TMOUT': '86400', 07:44:55 INFO - 'USER': 'cltbld', 07:44:55 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 07:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:55 INFO - '_': '/tools/buildbot/bin/python'} 07:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:55 INFO - Downloading/unpacking psutil>=3.1.1 07:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:44:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:57 INFO - Installing collected packages: psutil 07:44:57 INFO - Running setup.py install for psutil 07:44:57 INFO - building 'psutil._psutil_linux' extension 07:44:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:44:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:44:58 INFO - building 'psutil._psutil_posix' extension 07:44:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:44:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:44:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:58 INFO - Successfully installed psutil 07:44:58 INFO - Cleaning up... 07:44:58 INFO - Return code: 0 07:44:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7182fede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2838b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a62fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a64350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:44:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:44:58 INFO - Using env: {'DISPLAY': ':0', 07:44:58 INFO - 'HOME': '/home/cltbld', 07:44:58 INFO - 'LANG': 'en_US.UTF-8', 07:44:58 INFO - 'LANGUAGE': 'en_US:en', 07:44:58 INFO - 'LOGNAME': 'cltbld', 07:44:58 INFO - 'MAIL': '/var/mail/cltbld', 07:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:58 INFO - 'MOZ_NO_REMOTE': '1', 07:44:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:58 INFO - 'NO_EM_RESTART': '1', 07:44:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:58 INFO - 'PWD': '/builds/slave/test', 07:44:58 INFO - 'SHELL': '/bin/bash', 07:44:58 INFO - 'SHLVL': '1', 07:44:58 INFO - 'TERM': 'linux', 07:44:58 INFO - 'TMOUT': '86400', 07:44:58 INFO - 'USER': 'cltbld', 07:44:58 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 07:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:58 INFO - '_': '/tools/buildbot/bin/python'} 07:44:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:45:00 INFO - Installing collected packages: mozsystemmonitor 07:45:00 INFO - Running setup.py install for mozsystemmonitor 07:45:00 INFO - Successfully installed mozsystemmonitor 07:45:00 INFO - Cleaning up... 07:45:00 INFO - Return code: 0 07:45:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7182fede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2838b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a62fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a64350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:45:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:45:00 INFO - Using env: {'DISPLAY': ':0', 07:45:00 INFO - 'HOME': '/home/cltbld', 07:45:00 INFO - 'LANG': 'en_US.UTF-8', 07:45:00 INFO - 'LANGUAGE': 'en_US:en', 07:45:00 INFO - 'LOGNAME': 'cltbld', 07:45:00 INFO - 'MAIL': '/var/mail/cltbld', 07:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:00 INFO - 'MOZ_NO_REMOTE': '1', 07:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:00 INFO - 'NO_EM_RESTART': '1', 07:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:00 INFO - 'PWD': '/builds/slave/test', 07:45:00 INFO - 'SHELL': '/bin/bash', 07:45:00 INFO - 'SHLVL': '1', 07:45:00 INFO - 'TERM': 'linux', 07:45:00 INFO - 'TMOUT': '86400', 07:45:00 INFO - 'USER': 'cltbld', 07:45:00 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 07:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:00 INFO - '_': '/tools/buildbot/bin/python'} 07:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:00 INFO - Downloading/unpacking jsonschema==2.5.1 07:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:45:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:03 INFO - Downloading functools32-3.2.3-2.tar.gz 07:45:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:45:03 INFO - warning: no files found matching '*.txt' 07:45:03 INFO - no previously-included directories found matching 'build' 07:45:03 INFO - no previously-included directories found matching 'dist' 07:45:03 INFO - no previously-included directories found matching '.git*' 07:45:03 INFO - Installing collected packages: jsonschema, functools32 07:45:03 INFO - Running setup.py install for functools32 07:45:03 INFO - warning: no files found matching '*.txt' 07:45:03 INFO - no previously-included directories found matching 'build' 07:45:03 INFO - no previously-included directories found matching 'dist' 07:45:03 INFO - no previously-included directories found matching '.git*' 07:45:03 INFO - Successfully installed jsonschema functools32 07:45:03 INFO - Cleaning up... 07:45:03 INFO - Return code: 0 07:45:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7182fede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2838b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a62fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a64350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:45:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:45:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:45:03 INFO - Using env: {'DISPLAY': ':0', 07:45:03 INFO - 'HOME': '/home/cltbld', 07:45:03 INFO - 'LANG': 'en_US.UTF-8', 07:45:03 INFO - 'LANGUAGE': 'en_US:en', 07:45:03 INFO - 'LOGNAME': 'cltbld', 07:45:03 INFO - 'MAIL': '/var/mail/cltbld', 07:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:03 INFO - 'MOZ_NO_REMOTE': '1', 07:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:03 INFO - 'NO_EM_RESTART': '1', 07:45:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:03 INFO - 'PWD': '/builds/slave/test', 07:45:03 INFO - 'SHELL': '/bin/bash', 07:45:03 INFO - 'SHLVL': '1', 07:45:03 INFO - 'TERM': 'linux', 07:45:03 INFO - 'TMOUT': '86400', 07:45:03 INFO - 'USER': 'cltbld', 07:45:03 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 07:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:03 INFO - '_': '/tools/buildbot/bin/python'} 07:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:45:03 INFO - Cleaning up... 07:45:03 INFO - Return code: 0 07:45:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7182fede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2838b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a62fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a64350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:45:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:45:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:45:03 INFO - Using env: {'DISPLAY': ':0', 07:45:03 INFO - 'HOME': '/home/cltbld', 07:45:03 INFO - 'LANG': 'en_US.UTF-8', 07:45:03 INFO - 'LANGUAGE': 'en_US:en', 07:45:03 INFO - 'LOGNAME': 'cltbld', 07:45:03 INFO - 'MAIL': '/var/mail/cltbld', 07:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:03 INFO - 'MOZ_NO_REMOTE': '1', 07:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:03 INFO - 'NO_EM_RESTART': '1', 07:45:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:03 INFO - 'PWD': '/builds/slave/test', 07:45:03 INFO - 'SHELL': '/bin/bash', 07:45:03 INFO - 'SHLVL': '1', 07:45:03 INFO - 'TERM': 'linux', 07:45:03 INFO - 'TMOUT': '86400', 07:45:03 INFO - 'USER': 'cltbld', 07:45:03 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 07:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:03 INFO - '_': '/tools/buildbot/bin/python'} 07:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:03 INFO - Downloading/unpacking blobuploader==1.2.4 07:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:05 INFO - Downloading blobuploader-1.2.4.tar.gz 07:45:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:45:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:45:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:06 INFO - Downloading docopt-0.6.1.tar.gz 07:45:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:45:06 INFO - Installing collected packages: blobuploader, requests, docopt 07:45:06 INFO - Running setup.py install for blobuploader 07:45:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:45:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:45:06 INFO - Running setup.py install for requests 07:45:06 INFO - Running setup.py install for docopt 07:45:07 INFO - Successfully installed blobuploader requests docopt 07:45:07 INFO - Cleaning up... 07:45:07 INFO - Return code: 0 07:45:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7182fede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2838b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a62fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a64350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:45:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:45:07 INFO - Using env: {'DISPLAY': ':0', 07:45:07 INFO - 'HOME': '/home/cltbld', 07:45:07 INFO - 'LANG': 'en_US.UTF-8', 07:45:07 INFO - 'LANGUAGE': 'en_US:en', 07:45:07 INFO - 'LOGNAME': 'cltbld', 07:45:07 INFO - 'MAIL': '/var/mail/cltbld', 07:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:07 INFO - 'MOZ_NO_REMOTE': '1', 07:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:07 INFO - 'NO_EM_RESTART': '1', 07:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:07 INFO - 'PWD': '/builds/slave/test', 07:45:07 INFO - 'SHELL': '/bin/bash', 07:45:07 INFO - 'SHLVL': '1', 07:45:07 INFO - 'TERM': 'linux', 07:45:07 INFO - 'TMOUT': '86400', 07:45:07 INFO - 'USER': 'cltbld', 07:45:07 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 07:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:07 INFO - '_': '/tools/buildbot/bin/python'} 07:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:45:07 INFO - Running setup.py (path:/tmp/pip-JqjP0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:45:07 INFO - Running setup.py (path:/tmp/pip-lggCxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:45:07 INFO - Running setup.py (path:/tmp/pip-GZYIH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:45:07 INFO - Running setup.py (path:/tmp/pip-lxnTjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:45:07 INFO - Running setup.py (path:/tmp/pip-zeNCY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:45:07 INFO - Running setup.py (path:/tmp/pip-jW_0US-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:45:07 INFO - Running setup.py (path:/tmp/pip-uXW3Dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:45:07 INFO - Running setup.py (path:/tmp/pip-6eR741-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:45:07 INFO - Running setup.py (path:/tmp/pip-yl363D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:45:08 INFO - Running setup.py (path:/tmp/pip-TeBUek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:45:08 INFO - Running setup.py (path:/tmp/pip-nGUT6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:45:08 INFO - Running setup.py (path:/tmp/pip-mlqLwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:45:08 INFO - Running setup.py (path:/tmp/pip-zEaE5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:45:08 INFO - Running setup.py (path:/tmp/pip-WwwAi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:08 INFO - Running setup.py (path:/tmp/pip-2FRher-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:45:08 INFO - Running setup.py (path:/tmp/pip-izyqW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:45:08 INFO - Running setup.py (path:/tmp/pip-NEi0TZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:45:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:45:08 INFO - Running setup.py install for manifestparser 07:45:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:45:08 INFO - Running setup.py install for mozcrash 07:45:08 INFO - Running setup.py install for mozdebug 07:45:08 INFO - Running setup.py install for mozdevice 07:45:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:45:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:45:09 INFO - Running setup.py install for mozfile 07:45:09 INFO - Running setup.py install for mozhttpd 07:45:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:45:09 INFO - Running setup.py install for mozinfo 07:45:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:45:09 INFO - Running setup.py install for mozInstall 07:45:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:45:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:45:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:45:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:45:09 INFO - Running setup.py install for mozleak 07:45:09 INFO - Running setup.py install for mozlog 07:45:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:45:09 INFO - Running setup.py install for moznetwork 07:45:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:45:09 INFO - Running setup.py install for mozprocess 07:45:09 INFO - Running setup.py install for mozprofile 07:45:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:45:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:45:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:45:09 INFO - Running setup.py install for mozrunner 07:45:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:45:10 INFO - Running setup.py install for mozscreenshot 07:45:10 INFO - Running setup.py install for moztest 07:45:10 INFO - Running setup.py install for mozversion 07:45:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:45:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:45:10 INFO - Cleaning up... 07:45:10 INFO - Return code: 0 07:45:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7182fede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2838b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a62fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a64350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:45:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:45:10 INFO - Using env: {'DISPLAY': ':0', 07:45:10 INFO - 'HOME': '/home/cltbld', 07:45:10 INFO - 'LANG': 'en_US.UTF-8', 07:45:10 INFO - 'LANGUAGE': 'en_US:en', 07:45:10 INFO - 'LOGNAME': 'cltbld', 07:45:10 INFO - 'MAIL': '/var/mail/cltbld', 07:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:10 INFO - 'MOZ_NO_REMOTE': '1', 07:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:10 INFO - 'NO_EM_RESTART': '1', 07:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:10 INFO - 'PWD': '/builds/slave/test', 07:45:10 INFO - 'SHELL': '/bin/bash', 07:45:10 INFO - 'SHLVL': '1', 07:45:10 INFO - 'TERM': 'linux', 07:45:10 INFO - 'TMOUT': '86400', 07:45:10 INFO - 'USER': 'cltbld', 07:45:10 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 07:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:10 INFO - '_': '/tools/buildbot/bin/python'} 07:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:45:10 INFO - Running setup.py (path:/tmp/pip-gTCnUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:45:10 INFO - Running setup.py (path:/tmp/pip-WmAUH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:45:10 INFO - Running setup.py (path:/tmp/pip-qCTdK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:45:10 INFO - Running setup.py (path:/tmp/pip-gLKyqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:45:10 INFO - Running setup.py (path:/tmp/pip-QseGil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:45:10 INFO - Running setup.py (path:/tmp/pip-Jtb9AP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:45:11 INFO - Running setup.py (path:/tmp/pip-D1yoCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:45:11 INFO - Running setup.py (path:/tmp/pip-JJUY9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:45:11 INFO - Running setup.py (path:/tmp/pip-lwVOC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:45:11 INFO - Running setup.py (path:/tmp/pip-2ZDALr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:45:11 INFO - Running setup.py (path:/tmp/pip-CDqMMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:45:11 INFO - Running setup.py (path:/tmp/pip-WiOcVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:45:11 INFO - Running setup.py (path:/tmp/pip-fKuSrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:45:11 INFO - Running setup.py (path:/tmp/pip-_ppEcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:11 INFO - Running setup.py (path:/tmp/pip-mc9EMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:45:11 INFO - Running setup.py (path:/tmp/pip-RTirRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:45:11 INFO - Running setup.py (path:/tmp/pip-kxHJtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:45:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:13 INFO - Downloading blessings-1.6.tar.gz 07:45:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:45:13 INFO - Installing collected packages: blessings 07:45:13 INFO - Running setup.py install for blessings 07:45:14 INFO - Successfully installed blessings 07:45:14 INFO - Cleaning up... 07:45:14 INFO - Return code: 0 07:45:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:45:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:45:14 INFO - Reading from file tmpfile_stdout 07:45:14 INFO - Current package versions: 07:45:14 INFO - argparse == 1.2.1 07:45:14 INFO - blessings == 1.6 07:45:14 INFO - blobuploader == 1.2.4 07:45:14 INFO - docopt == 0.6.1 07:45:14 INFO - functools32 == 3.2.3-2 07:45:14 INFO - jsonschema == 2.5.1 07:45:14 INFO - manifestparser == 1.1 07:45:14 INFO - mozInstall == 1.12 07:45:14 INFO - mozcrash == 1.0 07:45:14 INFO - mozdebug == 0.1 07:45:14 INFO - mozdevice == 0.49 07:45:14 INFO - mozfile == 1.2 07:45:14 INFO - mozhttpd == 0.7 07:45:14 INFO - mozinfo == 0.9 07:45:14 INFO - mozleak == 0.1 07:45:14 INFO - mozlog == 3.4 07:45:14 INFO - moznetwork == 0.27 07:45:14 INFO - mozprocess == 0.23 07:45:14 INFO - mozprofile == 0.28 07:45:14 INFO - mozrunner == 6.13 07:45:14 INFO - mozscreenshot == 0.1 07:45:14 INFO - mozsystemmonitor == 0.3 07:45:14 INFO - moztest == 0.7 07:45:14 INFO - mozversion == 1.4 07:45:14 INFO - psutil == 3.1.1 07:45:14 INFO - requests == 1.2.3 07:45:14 INFO - wsgiref == 0.1.2 07:45:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7182fede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2838b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a62fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a64350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:45:14 INFO - Using env: {'DISPLAY': ':0', 07:45:14 INFO - 'HOME': '/home/cltbld', 07:45:14 INFO - 'LANG': 'en_US.UTF-8', 07:45:14 INFO - 'LANGUAGE': 'en_US:en', 07:45:14 INFO - 'LOGNAME': 'cltbld', 07:45:14 INFO - 'MAIL': '/var/mail/cltbld', 07:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:14 INFO - 'MOZ_NO_REMOTE': '1', 07:45:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:14 INFO - 'NO_EM_RESTART': '1', 07:45:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:14 INFO - 'PWD': '/builds/slave/test', 07:45:14 INFO - 'SHELL': '/bin/bash', 07:45:14 INFO - 'SHLVL': '1', 07:45:14 INFO - 'TERM': 'linux', 07:45:14 INFO - 'TMOUT': '86400', 07:45:14 INFO - 'USER': 'cltbld', 07:45:14 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 07:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:14 INFO - '_': '/tools/buildbot/bin/python'} 07:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:45:14 INFO - Cleaning up... 07:45:14 INFO - Return code: 0 07:45:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7182fede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2838b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a62fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a64350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:45:14 INFO - Using env: {'DISPLAY': ':0', 07:45:14 INFO - 'HOME': '/home/cltbld', 07:45:14 INFO - 'LANG': 'en_US.UTF-8', 07:45:14 INFO - 'LANGUAGE': 'en_US:en', 07:45:14 INFO - 'LOGNAME': 'cltbld', 07:45:14 INFO - 'MAIL': '/var/mail/cltbld', 07:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:14 INFO - 'MOZ_NO_REMOTE': '1', 07:45:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:14 INFO - 'NO_EM_RESTART': '1', 07:45:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:14 INFO - 'PWD': '/builds/slave/test', 07:45:14 INFO - 'SHELL': '/bin/bash', 07:45:14 INFO - 'SHLVL': '1', 07:45:14 INFO - 'TERM': 'linux', 07:45:14 INFO - 'TMOUT': '86400', 07:45:14 INFO - 'USER': 'cltbld', 07:45:14 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 07:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:14 INFO - '_': '/tools/buildbot/bin/python'} 07:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:45:14 INFO - Cleaning up... 07:45:14 INFO - Return code: 0 07:45:14 INFO - Running post-action listener: _resource_record_post_action 07:45:14 INFO - Running post-action listener: _start_resource_monitoring 07:45:14 INFO - Starting resource monitoring. 07:45:14 INFO - [mozharness: 2016-11-22 15:45:14.801792Z] Finished create-virtualenv step (success) 07:45:14 INFO - [mozharness: 2016-11-22 15:45:14.802265Z] Running install step. 07:45:14 INFO - Running pre-action listener: _resource_record_pre_action 07:45:14 INFO - Running main action method: install 07:45:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:45:15 INFO - Reading from file tmpfile_stdout 07:45:15 INFO - Detecting whether we're running mozinstall >=1.0... 07:45:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:45:15 INFO - Reading from file tmpfile_stdout 07:45:15 INFO - Output received: 07:45:15 INFO - Usage: mozinstall [options] installer 07:45:15 INFO - Options: 07:45:15 INFO - -h, --help show this help message and exit 07:45:15 INFO - -d DEST, --destination=DEST 07:45:15 INFO - Directory to install application into. [default: 07:45:15 INFO - "/builds/slave/test"] 07:45:15 INFO - --app=APP Application being installed. [default: firefox] 07:45:15 INFO - mkdir: /builds/slave/test/build/application 07:45:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:45:31 INFO - Reading from file tmpfile_stdout 07:45:31 INFO - Output received: 07:45:31 INFO - /builds/slave/test/build/application/firefox/firefox 07:45:31 INFO - Running post-action listener: _resource_record_post_action 07:45:31 INFO - [mozharness: 2016-11-22 15:45:31.554299Z] Finished install step (success) 07:45:31 INFO - [mozharness: 2016-11-22 15:45:31.554551Z] Running run-tests step. 07:45:31 INFO - Running pre-action listener: _resource_record_pre_action 07:45:31 INFO - Running main action method: run_tests 07:45:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:45:31 INFO - Python 2.7.3 07:45:31 INFO - Return code: 0 07:45:31 INFO - grabbing minidump binary from tooltool 07:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a62fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a63ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a64350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:45:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:45:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:45:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:45:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:45:31 INFO - Return code: 0 07:45:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:45:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:45:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:45:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:45:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:45:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:45:31 INFO - Using env: {'DISPLAY': ':0', 07:45:31 INFO - 'HOME': '/home/cltbld', 07:45:31 INFO - 'LANG': 'en_US.UTF-8', 07:45:31 INFO - 'LANGUAGE': 'en_US:en', 07:45:31 INFO - 'LOGNAME': 'cltbld', 07:45:31 INFO - 'MAIL': '/var/mail/cltbld', 07:45:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:45:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:31 INFO - 'MOZ_NO_REMOTE': '1', 07:45:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:31 INFO - 'NO_EM_RESTART': '1', 07:45:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:31 INFO - 'PWD': '/builds/slave/test', 07:45:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:45:31 INFO - 'SHELL': '/bin/bash', 07:45:31 INFO - 'SHLVL': '1', 07:45:31 INFO - 'TERM': 'linux', 07:45:31 INFO - 'TMOUT': '86400', 07:45:31 INFO - 'USER': 'cltbld', 07:45:31 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942', 07:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:31 INFO - '_': '/tools/buildbot/bin/python'} 07:45:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:45:31 INFO - mozversion application_buildid: 20161122062350 07:45:31 INFO - mozversion application_changeset: 39388a57920863c7487437a4571eb9186591e876 07:45:31 INFO - mozversion application_display_name: Nightly 07:45:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:45:31 INFO - mozversion application_name: Firefox 07:45:31 INFO - mozversion application_remotingname: firefox 07:45:31 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 07:45:31 INFO - mozversion application_vendor: Mozilla 07:45:31 INFO - mozversion application_version: 53.0a1 07:45:31 INFO - mozversion platform_buildid: 20161122062350 07:45:31 INFO - mozversion platform_changeset: 39388a57920863c7487437a4571eb9186591e876 07:45:31 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 07:45:31 INFO - mozversion platform_version: 53.0a1 07:45:31 INFO - using testdate: 1479829531 07:45:31 INFO - actual date: 1479829531 07:45:31 INFO - starting webserver on 'localhost:58149' 07:45:31 INFO - SUITE-START | Running 2 tests 07:45:31 INFO - TEST-START | dromaeo_css 07:45:31 INFO - operating with platform_type : linux_ 07:45:31 INFO - Initialising browser for dromaeo_css test... 07:45:31 INFO - TEST-INFO | started process 22603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNssSxU/profile http://localhost:58149/getInfo.html) 07:45:36 INFO - PROCESS | 22603 | __metrics Screen width/height:1600/1200 07:45:36 INFO - PROCESS | 22603 | colorDepth:24 07:45:36 INFO - PROCESS | 22603 | Browser inner width/height: 1024/697 07:45:36 INFO - PROCESS | 22603 | __metrics 07:45:37 ERROR - PROCESS | 22603 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 07:45:38 INFO - TEST-INFO | 22603: exit 0 07:45:38 INFO - Browser initialized. 07:45:38 INFO - Running cycle 1/1 for dromaeo_css test... 07:45:38 INFO - TEST-INFO | started process 22726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNssSxU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:45:50 INFO - PROCESS | 22726 | RSS: Main: 187322368 07:45:50 INFO - PROCESS | 22726 | 07:46:39 INFO - PROCESS | 22726 | 1479829599978 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:48:54 INFO - PROCESS | 22726 | Cycle 1(1): loaded http://localhost:58149/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58149/tests/dromaeo/cssquery-ext.html) 07:48:55 INFO - PROCESS | 22726 | RSS: Main: 196694016 07:48:55 INFO - PROCESS | 22726 | 07:51:58 INFO - PROCESS | 22726 | Cycle 1(1): loaded http://localhost:58149/tests/dromaeo/cssquery-ext.html (next: http://localhost:58149/tests/dromaeo/cssquery-jquery.html) 07:51:58 INFO - PROCESS | 22726 | RSS: Main: 197115904 07:51:58 INFO - PROCESS | 22726 | 07:55:01 INFO - PROCESS | 22726 | Cycle 1(1): loaded http://localhost:58149/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58149/tests/dromaeo/cssquery-mootools.html) 07:55:01 INFO - PROCESS | 22726 | RSS: Main: 199098368 07:55:01 INFO - PROCESS | 22726 | 07:58:03 INFO - PROCESS | 22726 | Cycle 1(1): loaded http://localhost:58149/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58149/tests/dromaeo/cssquery-prototype.html) 07:58:04 INFO - PROCESS | 22726 | RSS: Main: 195936256 07:58:04 INFO - PROCESS | 22726 | 08:01:07 INFO - PROCESS | 22726 | Cycle 1(1): loaded http://localhost:58149/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58149/tests/dromaeo/cssquery-yui.html) 08:01:08 INFO - PROCESS | 22726 | RSS: Main: 199151616 08:01:08 INFO - PROCESS | 22726 | 08:04:11 INFO - PROCESS | 22726 | Cycle 1(1): loaded http://localhost:58149/tests/dromaeo/cssquery-yui.html (next: http://localhost:58149/tests/dromaeo/cssquery-dojo.html) 08:04:11 INFO - PROCESS | 22726 | RSS: Main: 199131136 08:04:11 INFO - PROCESS | 22726 | 08:04:11 INFO - PROCESS | 22726 | __start_tp_report 08:04:11 INFO - PROCESS | 22726 | _x_x_mozilla_page_load 08:04:11 INFO - PROCESS | 22726 | _x_x_mozilla_page_load_details 08:04:11 INFO - PROCESS | 22726 | |i|pagename|runs| 08:04:11 INFO - PROCESS | 22726 | |0;dojo.html;2616.8037397195208;2617.267165193746;2628.382330152415;2651.6685414323206;2663.946721065579;4628.884277893055;4759.3812804335475;4788.353572267747;4833.758312084395;4844.103840789457;4637.698549594274;4668.276417155338;4679.204535229011;4709.340692303081;4715.717056976584;4298.9785051074705;4325.653947684185;4398;4411.845585404511;4471.306947423138;4311.137772445508;4361.411209486726;4464.776761161929;4509.165804326194;4533.773311334437;4246.830126794925;4281.743095414254;4283.764392958386;4417.933730994037;4422.778861056934;4272.060146767706;4283.229018776619;4289.013526888802;4297.312430011214;4347.760873151976;4266.445362102907;4311.417958575584;4318.265894797892;4384.583464570861;4388.210122178007;4750.239961606161;4765.618750499952;4787.8646579990545;4804.303376010494;4829.468758436569;5036.949630503685;5068.2144267638205;5145.151050076733;5148.794048238066;5163.225516172567;5134.0758663440565;5141.048905952373;5144.948550514484;5152.278680984665;5185.274061631375;4804.927926081112;4808.759562021885;4810.11012962603;4828.37231159954;4854.199057155565;5131.358580177478;5159.406668233126;5163.173892177234;5221.399539052982;5228.215767634885;4989.850304490871;4999.450060493343;5007.749612519432;5031.924521132186;5059.494050594911;4912.189488734391;4948.455669876311;5165.14775062118;5199.428062913076;5237.895242095213;4940.604751619861;4941.703497790072;4986.650934434628;4999.150144475448;5009.398872135367;4952.603791696655;4960.23116416956;4962.925556116661;4973.2042873140845;5004.299398084271;4240.978795106004;4311.310190369526;4321.762303073361;4361.345798130305;4379.080393117481;3775.188334508094;3800.5819359870393;3826.9808650956566;3849.634284742945;3858.440526123696;4411.2721400968485;4411.823527058882;4421.115776844644;4434.401355816988;4483.058557702919;4982.153033984159;5000.024995125988;5019.598432125421;5132.794688212504;5189.040027594907;4386.846460373871;4447.644188464915;4457.064016556495;4462.308342206963;4496.325551167286;4622.884427889262;4652.511486293891;4664.137134630037;4696.906061878812;4723.173444647173;4601.608863246662;4797.544233297831;4807.6394270429155;4809.903801923872;4854.757262136879;4971.229459433794;5028.974855125847;5032.119379108568;5034.84895453137;5046.1673823818655;4626.213543697512;4670.392848929618;4672.135654903854;4677;4680.7191568506;4925.48282430354;4976.278439626306;5030.874228144326;5046.9747651261505;5059.392872855134;5030.144875371268;5136.460671629425;5153.793848246029;5159.226116082617;5201;5020.217141549872;5020.698758074527;5023.447420783637;5028.34631497903;5067.898642027212;4830.178869592248;4857.708537487762;4941.382327209099;4986.351774269322;5022.773975171053;4950.702957822542;4958.42978057528;4961.70229786214;4963.776630051729;4964.205727083649;5023;5044.319016932814;5052.494750524918;5070.923936140887;5098.2352647103235;4750.406199225097;4815.3258543804595;4831.541003604652;4943.975280123576;4951.356323677899 08:04:11 INFO - PROCESS | 22726 | |1;ext.html;538.9407165211828;539.9082156033476;548.388546770351;549.8185598752412;556.952659023983;28040.579391309147;37481.625183748154;38741.41887871684;38980.22039559214;42238.78880605601;37607.62392376075;37897.621023789754;37945.430818537745;37979.24041519168;38053.42919856197;7378.520396174258;7495.475316727831;7505.211952744965;7507.924920750777;7513.699452021912;7431.628418579076;7463.2163622819635;7483.251674832501;7519.962400187991;7549.735759248428;7493.925060749377;7501.212372700869;7508.737194198204;7515.549067055994;7517.135529414105;7417.7774666759815;7485.887711684329;7487.438442116809;7495.512791668524;7495.812604684872;7424.96287518559;7510.1738808731;7515;7559.962200188964;7567.432442566775;36179.4573081404;36512.452313215326;36573.63426365729;36667;36854.447183292;3041.2092855857413;3243.4810430331036;3340.4321265384942;3410.28384039352;3586.7309951753464;26836.865815670993;26933.595996060074;28034.299142521395;28164.43671126566;28286.591362918465;3356.63077061523;3452.879149229765;3478.5825700916052;3486.564179477565;3588.982055089708;250253;251445;251717.7414112936;251724;252119;48494;48862.75568622134;48878;48878.26682599764;48895.75552122216;31256;32148.83925580404;32256.677433225836;51303.230451543255;51637;12133.635990920286;12362.75274494505;12363.814542781865;12396.194247374073;12441.191322564004;9179.357444978787;9197.310201734897;9223.815523689489;9263.90736092644;9272.072792720808;17217.91391043037;17266.395676151275;17321.826781732023;17401.216945237495;17471;6781.694823732944;6814.386705196457;6874.312568743186;6914.792556223321;6960.617166055916;769.8037000564821;936.3118108190474;943.6272672294406;948.2840455456087;1011.4588695048114;26123.608145877828;26750.197494075208;27147.457050859266;27153.728462715517;27245;903.4263242840843;903.7059916603941;920.07992007992;925.121134921827;1005.1154983614518;13832.515861944985;13855.653608659662;13922.09506382082;14191;14209.431622735181;365720;366818;367987;368052;373035;45356.77321613371;45951.31073033907;46089;46101.538984609724;46190;1148.052856393462;1166.935818529972;1186.8753780853058;1189.6847335456112;1203.8374819399444;24181.15365962183;26255.73744262533;28469.288267793472;28972.13083607495;30571.23571910631;45254;46114.769426152656;46117.30824037575;46123.538764613266;46175.07649846917;344701;349534;349908;350989;351129;20541;21162.894185528974;21269.255576054762;36030.63969360273;36558;37268.254634907695;37904;38177.618223818514;38667.80666096652;38703.22593548057;32564.348713025134;32706.34587308193;32737.34525309528;32867.671323286464;33088.338233235685;31753;32399.028029159163;32647.673523264464;32815;32883.01350959475;31972.520412194302;32139;32231.677683222868;33902;37537.18471114623;29663.25841853971;30760;32061.198470037503;32423.513647295782;32657.346853062332;24519;24575.87712061428;24665.260042198763;24934;25163.370915727253 08:04:11 INFO - PROCESS | 22726 | |2;jquery.html;346.0915097868096;347.17199479242;350.32037846577646;360.8177870175561;373.5480069116369;15319.234038298082;16129.83870161298;17198.914005429986;17269.136543172855;17300.567485812862;15285.541433757006;16568.337266509356;16689.24898379573;16708.164591770423;16746.24641891115;4359.564043595631;4613.284940834176;4632.791524381394;4681;4703.717776933395;3497.178163131662;4631.8147274109;4657.06858628274;4658.277966915133;4671.416072990876;3649.671529562339;5041.8487445376695;5250.9474905250845;5281.498257665535;5334.053070629231;5166.43169251382;5306.336707911511;5311.814086506973;5324.467553244664;5332.600054995852;5201.817936372247;5209.973950130225;5216.713080780555;5216.9739151304;5217.869553261199;12105.273683579013;12410.937945310216;17880.55298617532;19701.605967880707;20258.189672413235;1839.245909177231;1890.7920128785822;1891.7540719706487;1932.671445854208;2081.250749730096;8410.36922230835;8833.602487887996;9037.457752534803;9342.57958391874;9399.57701903416;1611.113887361958;1641.4829328761402;1708.9743653845203;1710.9657806843793;1737.1574786228668;59062.704686476725;60792.603698150924;70780;71760;72130.63934680345;8076.636551355203;8600.182982616641;8738.825223495494;8775.868361974575;9809.027343925722;11247.325160490396;11252.324860508395;11287.322760634388;11314.264572802742;11382.032527235278;6098.115773212948;6119.2350956130485;6285.402886725754;6345.460635846005;6350.936490635127;5833.183354330397;5890.204822349014;5972.701364931736;5979.970100149471;6069.696515174312;3416.8633254669535;3442.2599141184764;3452.223249768782;3463.5324231228965;3508.9122771930397;1767.5227688524026;1795.985268323393;1834.8715589908845;1851.6944704123669;1853.2957476159243;364.4005610770268;371.8494009925984;385.1238432565879;385.56623798226997;396.843246917466;10518.684439466828;10903.236773425784;10918.727031824268;10919.235653504338;10976;397.00504962562775;397.67986770649327;404.75310060862853;415.5968710350955;417.7848408069846;5338.412774594792;5376.946230537645;5558.110702287615;5621.8594535136945;5680.091185410314;406363;406462;408517;413634;414933;79035.60482197552;80111;82016.58991705003;83860.58069709613;86105.56947215224;406.0397160714888;415.146873175627;416.1427459433576;416.7083041870642;417.3406018490777;9993.700188994342;10169.84745228837;10275.794484110425;14156.575302740934;15738.370465181264;36496.27007459889;36601;37214.62785372112;37498.81250593839;38573.80713096417;47802.28296575484;47868;48066.27900581424;48126.759366204344;49053;6844.794656160323;6981.3367730065565;7370.96314518424;7584.2794934481135;7679.616019199129;10258.692239232834;11371.090312774793;11622.0702343814;11665.708357291136;11680.299182049104;9462.290328225274;9847.458389788344;9918.801623967336;9945.751356216153;9980.850287245843;10103.595856165672;10124.392536447836;10261.58953641846;10335.896641033494;10390.844137338097;9989.700308990741;10044.196464282986;10048.949755251177;10501.842472363074;10617.787644247226;7527.096748390229;7620.428467864822;7623.542587444771;7726.956860823717;7754.596075216701;9645.614175433186;10285.331453455501;10311;10419.479026048819;10707.089897358812 08:04:11 INFO - PROCESS | 22726 | |3;mootools.html;1332.1807088640487;1358.1307962903743;1416.914985100894;1572.3396173607084;1614.580209145622;5750.252467179261;5933.643981361121;6297.779577714781;6742.224644165916;6845.041694162821;6286.402791734778;6559.868802623944;6576.210854697431;6633.668316584176;6711.899321510181;1963.96072078558;2025.4733769220036;2031.187524990001;2031.806978337063;2038.5005673609987;1987.4534503011644;2040.0513761101085;2040.9591808163827;2042.5200077981663;2046.1713006232499;1949.0741897598598;1966.7246585478044;1968.9901550492227;1989.8359459716085;1992.721019057333;1955.2081407030105;1975.4271261334195;1975.6147551227516;1976.3675623800389;1979.475439008664;1949.8440124789984;1957.5986922680815;1966;1998.510364960594;2002.819746222847;6710.93289067108;6759.9522074078595;6791.4227290679855;6800.829979250509;6835.213950395669;3932.46911666927;4055.8174882130374;4057.756534607933;4058.269511487931;4061.5938406159444;2619.266605350505;2717.388587567801;2773.459175460786;2791.776657867366;2800.8739606717745;844.4806444036934;863.0721973878043;889.9911000889973;898.4384759525296;905.6830109461636;7960.203979602052;8414;8521.44610600309;8731.170538798804;8780.034196238472;3308.2225676965895;3381.2730262993573;3453.689167974894;3463.6709512596262;3479.373712731682;7050.048243487064;7050.330218629222;7058.223595404502;7060.188078371053;7068.081149450539;4008.3386241270446;4014.6788256939376;4017.5982401760175;4019.2363450944226;4023.8189281482405;3248.13924310058;3354.5974483062187;3609.9278014439565;3761.360568703327;3773.415120656303;2819.182437093261;2852.3867368515866;2917.4311009353396;2944.985275073611;2973.687762784876;890.7773056735816;895.6283142495791;902.837489251941;905.4069584422082;907.26964793342;691.180950573572;798.6685525506849;839.5466448117947;847.7626264645909;859.4456575508761;4638.95361046392;4785.210440277385;4859.465458799529;4889.3888263967;5147.897042059138;405.3514376996782;405.5640186799144;406.6482492643901;408.3996525108146;409.44929070400264;3226.1934516370907;3407.4037043517783;3517.120719820045;3521.4189658706537;3641.8543258269374;7726.497777644435;8061.193880612009;8068.7175948841505;8069.83860322802;8075.87886181696;8041.075276343296;8062.798430039296;8065.314448271963;8065.435419520577;8083.030036395553;6341.143945567289;6352.396522330371;6428.871422571522;6430.710618022294;6489.805305840832;4662.766861656835;4696.835610753607;4781.42622885256;4786.44955830084;4879.072976134523;7155.356017958408;7168.53404528704;7233.927660723325;7288;7300.598467084362;7299.8540029200185;7300.744473943387;7324.267573242633;7385.889211661722;7391.630418478947;4971.37857767779;5664.745086471036;5671.404502527175;5699.48963524658;5715.257016587817;5756.1941328214925;6160.353162917829;6297.716602752978;6308.243010838729;6427.389398007182;5812.273465816773;5818.592698511064;5831.766729330949;5906.911396329145;5910.290765108214;5750.971245143747;5763.510101641407;5782.710864456844;5816.302043754607;5851.385604511465;5408.13469844823;5416.783328666967;5417.83746487606;5477.342718873601;5578.414266502121;4064.4919385076864;4133.23535145999;4169.395437661583;4269.188854117708;4447.466304043535;4039.6970227233664;4102.91794164121;4163;4249.277622804069;4356.607905288539 08:04:11 INFO - PROCESS | 22726 | |4;prototype.html;280.76836609796914;284.36160818961434;292.65466749235907;292.80089539113396;300.3752195433496;4835.9274610880775;4883.951160488394;4980.203167493201;4989.426215985162;4994.575461085812;4766.78549465274;4900.509949005098;4917.4099108107075;4917.557419832215;4919.409670839495;3802.6500592289754;3841.5390153181656;3846.0577658091584;3846.499955005845;3854.286956912966;3600.4419315006085;3833.367494363427;3838.309104361214;3866.76799392036;3870.7677539347587;3735.8692445764405;3773.9433908491396;3777.7922214278206;3788.9918343278105;3789.147441825581;3749.381352076904;3763.1909139534996;3770.6983441324764;3776.811159442017;3778;3108.875644974198;3171.31816659417;3180.491121420585;3286.408446479633;3294.357600267949;4779.733370656779;4794.976025119852;4795.808167673289;4800.591949684281;4805.543473370024;4245.214635292481;4258.212230737293;4258.61672449481;4259.787010649455;4278.315469524861;4964.429090654585;5091.66904151229;5097.541221290065;5109.6167787415725;5128.538431541142;3467.6705712957482;3502.6689857854108;3517.7537572369943;3526.1537231064617;3528.400171970771;5401.972990135064;5403.78384864605;5408.648437851566;5415.6479828811;5423.891522169574;3544.7742554275487;3545.2200515886466;3550.627184145679;3553.218291975761;3562.98218508911;3425.143714071482;3606.7655602386285;3623.8188090595363;3638.181409182913;3650.8904732858055;4204.306289462204;4206.3690446432665;4209.431726716915;4213.346931225665;4267.4025636410925;5116.667416617908;5128.79484820603;5136.948630513722;5185.792568297225;5204.583633309327;1175.9470823812778;1182.7161481244439;1222.706550427891;1235.2897084176454;1241.490988694631;796.1520980156231;819.1071731812353;819.1112642782529;822.621594066736;830.1947111302028;4314.439122914064;4326.394304797331;4341.370501277297;4349.217140914666;4379.321205213197;5099;5104.183330667075;5105.9744701276995;5107.361579802525;5128.307678463434;4353.782310884443;4377.942367087464;4384.6273066789045;4392.2094023075515;4399.252127138394;2645.4973555024485;2699.838009719423;2708.390612112259;2713.710987281065;2737.534619114755;4741.364229340872;4744.572988431058;4749.907521270127;4759.405074365704;4776.641751868624;5026.271190677331;5184.611154163453;5263;5295.311609490742;5331.253624492574;4610.008848097675;4717.905641887143;4738.194506933898;4742.430908291027;4787.133018122865;5018.3977922648055;5084.322173682602;5098.745062746773;5105.030044291572;5155.304033955368;4887.706737595756;4952.182889823139;4952.57903078228;4974.278729584263;4983.526564976321;4572.382728331632;4742.359781429601;4745.572898439157;4761.595264402426;4766.61867050642;3500.789952602852;3512.5960514541157;3514.314708631792;3514.876979305712;3556.8399422025554;5144.588432925282;5201.505856943584;5209.739513024258;5210.889589716171;5230.320058392384;4629.712903838178;5128.974355128201;5135.948640513697;5154.433012368711;5154.716490593053;5132.845109850254;5135.3324067870935;5146.841960558844;5147.716875571879;5158.484151584961;4888.291197776373;5102.43873173958;5104.719240441663;5126.923096153635;5153.4073581538605;5213.478652134756;5224.947750522446;5229.346331708536;5235.973820130875;5241.659292145999;5118.155504341742;5119.795208191631;5122.206058061007;5137.640365174402;5148.922766158586 08:04:11 INFO - PROCESS | 22726 | |5;yui.html;642.5983760149907;647.1522305779426;660.3165723476203;730.4120183252479;742.4728442805609;12404.069694772894;13441;13464.596062118128;13485.325733713324;13511.121777084483;12474.625761227155;12551.246925184496;12580.68548286291;12634.747305053894;12635.115541912046;619.7459041792865;637.7130291368879;751.7519218657857;766.4022062791004;778.9727359542388;763.2138896936165;781.0744268042388;783.5181363461459;783.7413653494333;785.3756263770288;826.2192228344217;829.2992421403904;831.1314676163394;831.9808234912215;832.6919039955225;822.411975437562;823.472977294532;824.7113510271417;825.4098319701442;825.8183199696057;611.3916652930318;614.1463365921372;614.8309214965875;615.1203778596605;615.157234588612;12742.61772146837;12802.231866088065;12954.157979731288;13001.414936327794;13007.609771706864;12321.568745093879;12823.807642885364;12885.871141288655;13048.739025219442;13236.602901912958;9826.410415375029;9835.393620690522;9926.702198934043;9991.250656200742;10053.346532475365;3155.179653290138;3213.678632136791;3241.789283696552;3351.8826841060445;3355.865765369382;54095;54365.72817135928;54523.727381363235;54603.453965460234;56213.156802647994;9747.951260243653;9910.20718342531;9918.305718599773;10132.138768204784;10464.319819211727;15812.36750529989;18908.243670253036;19066.904665476584;19074.52313692141;19111.52221194481;6409.487241020707;6485.77299794505;6566.277709451956;6585.604863708097;6710.664466776641;3428.5371474850576;3491.493733408692;3549.662782035754;3554.4668299755244;3637.8726744563814;2819.4643017826547;2849.700781417963;2905.709429057077;2907.9854600726862;2909.2145120817263;479.82486392467194;481.0787342239572;483.3860996534382;484.3388774323094;489.67926008464514;520.7344254430268;523.1838332201702;543.8667526456044;584.3163498706524;606.8816580766796;7265;7315.817104572322;7481.625918704043;7573.166951635316;7573.242675732383;576.6453631016979;589.1869220475802;591.4913174669781;591.9171316015761;595.2707932782394;3361.8991430257133;3412.3004784019217;3424.279354341274;3575.8927232183078;3578.141246100969;39388;53942.7302863491;55978;56427;61197;40308.59691403049;45317.32024019642;64257;64705.35294647088;64896;45002.54997450049;57812;58403.4159658398;60490.092648609425;61356.386436136854;7466.178720340867;7802.960985195038;7822.843543129219;7899.723509677134;8033.7188198415115;38798.80600596979;39496.60503395044;39551.60448395594;39575.80212098921;40425.39361909515;49300.75349623229;49418.50581494139;51126.23310650417;53197.46802531925;55558.72220638871;11271.211015228855;11445.542178312775;11538.82691759641;11650.825237621611;12371.13402061847;11766;12063.577774777841;12257.14200005991;12257.325847078497;12369.62891113268;10588.417637030037;11118.444077796239;11192.552297907992;11429.085673146295;11513.597024104116;10463.372197668165;10585.311954722918;10748.247622666338;11260.718482038015;11457.942710286396;10080.445575493419;10152.23858210652;10562.049415552638;11119.944400277947;11309.547618095514;9074.911010678497;9294.628214871329;9409.717708468757;9538.666146684833;9958.302918795614;9217.262618990331;9606.66376676813;9878.4566848824;9911.157551607906;9916.702498925044 08:04:11 INFO - PROCESS | 22726 | __end_tp_report 08:04:11 INFO - PROCESS | 22726 | __start_cc_report 08:04:11 INFO - PROCESS | 22726 | _x_x_mozilla_cycle_collect,343 08:04:11 INFO - PROCESS | 22726 | __end_cc_report 08:04:11 INFO - PROCESS | 22726 | __startTimestamp1479830651539__endTimestamp 08:04:11 INFO - PROCESS | 22726 | 08:04:11 INFO - PROCESS | 22726 | ------- Summary: start ------- 08:04:11 INFO - PROCESS | 22726 | Number of tests: 6 08:04:11 INFO - PROCESS | 22726 | 08:04:11 INFO - PROCESS | 22726 | [#0] dojo.html Cycles:165 Average:4702.55 Median:4829.47 stddev:492.44 (10.2%) stddev-sans-first:465.97 08:04:11 INFO - PROCESS | 22726 | Values: 2616.8 2617.3 2628.4 2651.7 2663.9 4628.9 4759.4 4788.4 4833.8 4844.1 4637.7 4668.3 4679.2 4709.3 4715.7 4299.0 4325.7 4398.0 4411.8 4471.3 4311.1 4361.4 4464.8 4509.2 4533.8 4246.8 4281.7 4283.8 4417.9 4422.8 4272.1 4283.2 4289.0 4297.3 4347.8 4266.4 4311.4 4318.3 4384.6 4388.2 4750.2 4765.6 4787.9 4804.3 4829.5 5036.9 5068.2 5145.2 5148.8 5163.2 5134.1 5141.0 5144.9 5152.3 5185.3 4804.9 4808.8 4810.1 4828.4 4854.2 5131.4 5159.4 5163.2 5221.4 5228.2 4989.9 4999.5 5007.7 5031.9 5059.5 4912.2 4948.5 5165.1 5199.4 5237.9 4940.6 4941.7 4986.7 4999.2 5009.4 4952.6 4960.2 4962.9 4973.2 5004.3 4241.0 4311.3 4321.8 4361.3 4379.1 3775.2 3800.6 3827.0 3849.6 3858.4 4411.3 4411.8 4421.1 4434.4 4483.1 4982.2 5000.0 5019.6 5132.8 5189.0 4386.8 4447.6 4457.1 4462.3 4496.3 4622.9 4652.5 4664.1 4696.9 4723.2 4601.6 4797.5 4807.6 4809.9 4854.8 4971.2 5029.0 5032.1 5034.8 5046.2 4626.2 4670.4 4672.1 4677.0 4680.7 4925.5 4976.3 5030.9 5047.0 5059.4 5030.1 5136.5 5153.8 5159.2 5201.0 5020.2 5020.7 5023.4 5028.3 5067.9 4830.2 4857.7 4941.4 4986.4 5022.8 4950.7 4958.4 4961.7 4963.8 4964.2 5023.0 5044.3 5052.5 5070.9 5098.2 4750.4 4815.3 4831.5 4944.0 4951.4 08:04:11 INFO - PROCESS | 22726 | 08:04:11 INFO - PROCESS | 22726 | [#1] ext.html Cycles:180 Average:46423.00 Median:36535.23 stddev:86231.84 (236.0%) stddev-sans-first:86404.93 08:04:11 INFO - PROCESS | 22726 | Values: 538.9 539.9 548.4 549.8 557.0 28040.6 37481.6 38741.4 38980.2 42238.8 37607.6 37897.6 37945.4 37979.2 38053.4 7378.5 7495.5 7505.2 7507.9 7513.7 7431.6 7463.2 7483.3 7520.0 7549.7 7493.9 7501.2 7508.7 7515.5 7517.1 7417.8 7485.9 7487.4 7495.5 7495.8 7425.0 7510.2 7515.0 7560.0 7567.4 36179.5 36512.5 36573.6 36667.0 36854.4 3041.2 3243.5 3340.4 3410.3 3586.7 26836.9 26933.6 28034.3 28164.4 28286.6 3356.6 3452.9 3478.6 3486.6 3589.0 250253.0 251445.0 251717.7 251724.0 252119.0 48494.0 48862.8 48878.0 48878.3 48895.8 31256.0 32148.8 32256.7 51303.2 51637.0 12133.6 12362.8 12363.8 12396.2 12441.2 9179.4 9197.3 9223.8 9263.9 9272.1 17217.9 17266.4 17321.8 17401.2 17471.0 6781.7 6814.4 6874.3 6914.8 6960.6 769.8 936.3 943.6 948.3 1011.5 26123.6 26750.2 27147.5 27153.7 27245.0 903.4 903.7 920.1 925.1 1005.1 13832.5 13855.7 13922.1 14191.0 14209.4 365720.0 366818.0 367987.0 368052.0 373035.0 45356.8 45951.3 46089.0 46101.5 46190.0 1148.1 1166.9 1186.9 1189.7 1203.8 24181.2 26255.7 28469.3 28972.1 30571.2 45254.0 46114.8 46117.3 46123.5 46175.1 344701.0 349534.0 349908.0 350989.0 351129.0 20541.0 21162.9 21269.3 36030.6 36558.0 37268.3 37904.0 38177.6 38667.8 38703.2 32564.3 32706.3 32737.3 32867.7 33088.3 31753.0 32399.0 32647.7 32815.0 32883.0 31972.5 32139.0 32231.7 33902.0 37537.2 29663.3 30760.0 32061.2 32423.5 32657.3 24519.0 24575.9 24665.3 24934.0 25163.4 08:04:11 INFO - PROCESS | 22726 | 08:04:11 INFO - PROCESS | 22726 | [#2] jquery.html Cycles:180 Average:24042.65 Median:411075.50 stddev:67799.38 (16.5%) stddev-sans-first:67966.22 08:04:11 INFO - PROCESS | 22726 | Values: 346.1 347.2 350.3 360.8 373.5 15319.2 16129.8 17198.9 17269.1 17300.6 15285.5 16568.3 16689.2 16708.2 16746.2 4359.6 4613.3 4632.8 4681.0 4703.7 3497.2 4631.8 4657.1 4658.3 4671.4 3649.7 5041.8 5250.9 5281.5 5334.1 5166.4 5306.3 5311.8 5324.5 5332.6 5201.8 5210.0 5216.7 5217.0 5217.9 12105.3 12410.9 17880.6 19701.6 20258.2 1839.2 1890.8 1891.8 1932.7 2081.3 8410.4 8833.6 9037.5 9342.6 9399.6 1611.1 1641.5 1709.0 1711.0 1737.2 59062.7 60792.6 70780.0 71760.0 72130.6 8076.6 8600.2 8738.8 8775.9 9809.0 11247.3 11252.3 11287.3 11314.3 11382.0 6098.1 6119.2 6285.4 6345.5 6350.9 5833.2 5890.2 5972.7 5980.0 6069.7 3416.9 3442.3 3452.2 3463.5 3508.9 1767.5 1796.0 1834.9 1851.7 1853.3 364.4 371.8 385.1 385.6 396.8 10518.7 10903.2 10918.7 10919.2 10976.0 397.0 397.7 404.8 415.6 417.8 5338.4 5376.9 5558.1 5621.9 5680.1 406363.0 406462.0 408517.0 413634.0 414933.0 79035.6 80111.0 82016.6 83860.6 86105.6 406.0 415.1 416.1 416.7 417.3 9993.7 10169.8 10275.8 14156.6 15738.4 36496.3 36601.0 37214.6 37498.8 38573.8 47802.3 47868.0 48066.3 48126.8 49053.0 6844.8 6981.3 7371.0 7584.3 7679.6 10258.7 11371.1 11622.1 11665.7 11680.3 9462.3 9847.5 9918.8 9945.8 9980.9 10103.6 10124.4 10261.6 10335.9 10390.8 9989.7 10044.2 10048.9 10501.8 10617.8 7527.1 7620.4 7623.5 7727.0 7754.6 9645.6 10285.3 10311.0 10419.5 10707.1 08:04:11 INFO - PROCESS | 22726 | 08:04:11 INFO - PROCESS | 22726 | [#3] mootools.html Cycles:180 Average:4378.94 Median:5278.02 stddev:2330.38 (44.2%) stddev-sans-first:2325.67 08:04:11 INFO - PROCESS | 22726 | Values: 1332.2 1358.1 1416.9 1572.3 1614.6 5750.3 5933.6 6297.8 6742.2 6845.0 6286.4 6559.9 6576.2 6633.7 6711.9 1964.0 2025.5 2031.2 2031.8 2038.5 1987.5 2040.1 2041.0 2042.5 2046.2 1949.1 1966.7 1969.0 1989.8 1992.7 1955.2 1975.4 1975.6 1976.4 1979.5 1949.8 1957.6 1966.0 1998.5 2002.8 6710.9 6760.0 6791.4 6800.8 6835.2 3932.5 4055.8 4057.8 4058.3 4061.6 2619.3 2717.4 2773.5 2791.8 2800.9 844.5 863.1 890.0 898.4 905.7 7960.2 8414.0 8521.4 8731.2 8780.0 3308.2 3381.3 3453.7 3463.7 3479.4 7050.0 7050.3 7058.2 7060.2 7068.1 4008.3 4014.7 4017.6 4019.2 4023.8 3248.1 3354.6 3609.9 3761.4 3773.4 2819.2 2852.4 2917.4 2945.0 2973.7 890.8 895.6 902.8 905.4 907.3 691.2 798.7 839.5 847.8 859.4 4639.0 4785.2 4859.5 4889.4 5147.9 405.4 405.6 406.6 408.4 409.4 3226.2 3407.4 3517.1 3521.4 3641.9 7726.5 8061.2 8068.7 8069.8 8075.9 8041.1 8062.8 8065.3 8065.4 8083.0 6341.1 6352.4 6428.9 6430.7 6489.8 4662.8 4696.8 4781.4 4786.4 4879.1 7155.4 7168.5 7233.9 7288.0 7300.6 7299.9 7300.7 7324.3 7385.9 7391.6 4971.4 5664.7 5671.4 5699.5 5715.3 5756.2 6160.4 6297.7 6308.2 6427.4 5812.3 5818.6 5831.8 5906.9 5910.3 5751.0 5763.5 5782.7 5816.3 5851.4 5408.1 5416.8 5417.8 5477.3 5578.4 4064.5 4133.2 4169.4 4269.2 4447.5 4039.7 4102.9 4163.0 4249.3 4356.6 08:04:11 INFO - PROCESS | 22726 | 08:04:11 INFO - PROCESS | 22726 | [#4] prototype.html Cycles:180 Average:4178.42 Median:4754.66 stddev:1242.97 (26.1%) stddev-sans-first:1211.54 08:04:11 INFO - PROCESS | 22726 | Values: 280.8 284.4 292.7 292.8 300.4 4835.9 4884.0 4980.2 4989.4 4994.6 4766.8 4900.5 4917.4 4917.6 4919.4 3802.7 3841.5 3846.1 3846.5 3854.3 3600.4 3833.4 3838.3 3866.8 3870.8 3735.9 3773.9 3777.8 3789.0 3789.1 3749.4 3763.2 3770.7 3776.8 3778.0 3108.9 3171.3 3180.5 3286.4 3294.4 4779.7 4795.0 4795.8 4800.6 4805.5 4245.2 4258.2 4258.6 4259.8 4278.3 4964.4 5091.7 5097.5 5109.6 5128.5 3467.7 3502.7 3517.8 3526.2 3528.4 5402.0 5403.8 5408.6 5415.6 5423.9 3544.8 3545.2 3550.6 3553.2 3563.0 3425.1 3606.8 3623.8 3638.2 3650.9 4204.3 4206.4 4209.4 4213.3 4267.4 5116.7 5128.8 5136.9 5185.8 5204.6 1175.9 1182.7 1222.7 1235.3 1241.5 796.2 819.1 819.1 822.6 830.2 4314.4 4326.4 4341.4 4349.2 4379.3 5099.0 5104.2 5106.0 5107.4 5128.3 4353.8 4377.9 4384.6 4392.2 4399.3 2645.5 2699.8 2708.4 2713.7 2737.5 4741.4 4744.6 4749.9 4759.4 4776.6 5026.3 5184.6 5263.0 5295.3 5331.3 4610.0 4717.9 4738.2 4742.4 4787.1 5018.4 5084.3 5098.7 5105.0 5155.3 4887.7 4952.2 4952.6 4974.3 4983.5 4572.4 4742.4 4745.6 4761.6 4766.6 3500.8 3512.6 3514.3 3514.9 3556.8 5144.6 5201.5 5209.7 5210.9 5230.3 4629.7 5129.0 5135.9 5154.4 5154.7 5132.8 5135.3 5146.8 5147.7 5158.5 4888.3 5102.4 5104.7 5126.9 5153.4 5213.5 5224.9 5229.3 5236.0 5241.7 5118.2 5119.8 5122.2 5137.6 5148.9 08:04:11 INFO - PROCESS | 22726 | 08:04:11 INFO - PROCESS | 22726 | [#5] yui.html Cycles:180 Average:14405.42 Median:521.96 stddev:17843.90 (3418.6%) stddev-sans-first:17864.03 08:04:11 INFO - PROCESS | 22726 | Values: 642.6 647.2 660.3 730.4 742.5 12404.1 13441.0 13464.6 13485.3 13511.1 12474.6 12551.2 12580.7 12634.7 12635.1 619.7 637.7 751.8 766.4 779.0 763.2 781.1 783.5 783.7 785.4 826.2 829.3 831.1 832.0 832.7 822.4 823.5 824.7 825.4 825.8 611.4 614.1 614.8 615.1 615.2 12742.6 12802.2 12954.2 13001.4 13007.6 12321.6 12823.8 12885.9 13048.7 13236.6 9826.4 9835.4 9926.7 9991.3 10053.3 3155.2 3213.7 3241.8 3351.9 3355.9 54095.0 54365.7 54523.7 54603.5 56213.2 9748.0 9910.2 9918.3 10132.1 10464.3 15812.4 18908.2 19066.9 19074.5 19111.5 6409.5 6485.8 6566.3 6585.6 6710.7 3428.5 3491.5 3549.7 3554.5 3637.9 2819.5 2849.7 2905.7 2908.0 2909.2 479.8 481.1 483.4 484.3 489.7 520.7 523.2 543.9 584.3 606.9 7265.0 7315.8 7481.6 7573.2 7573.2 576.6 589.2 591.5 591.9 595.3 3361.9 3412.3 3424.3 3575.9 3578.1 39388.0 53942.7 55978.0 56427.0 61197.0 40308.6 45317.3 64257.0 64705.4 64896.0 45002.5 57812.0 58403.4 60490.1 61356.4 7466.2 7803.0 7822.8 7899.7 8033.7 38798.8 39496.6 39551.6 39575.8 40425.4 49300.8 49418.5 51126.2 53197.5 55558.7 11271.2 11445.5 11538.8 11650.8 12371.1 11766.0 12063.6 12257.1 12257.3 12369.6 10588.4 11118.4 11192.6 11429.1 11513.6 10463.4 10585.3 10748.2 11260.7 11457.9 10080.4 10152.2 10562.0 11119.9 11309.5 9074.9 9294.6 9409.7 9538.7 9958.3 9217.3 9606.7 9878.5 9911.2 9916.7 08:04:11 INFO - PROCESS | 22726 | -------- Summary: end -------- 08:04:11 INFO - PROCESS | 22726 | 08:04:12 INFO - TEST-INFO | 22726: exit 0 08:04:12 INFO - TEST-OK | dromaeo_css | took 1120839ms 08:04:12 INFO - TEST-START | kraken 08:04:12 INFO - operating with platform_type : linux_ 08:04:12 INFO - Initialising browser for kraken test... 08:04:12 INFO - TEST-INFO | started process 23087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY2XCFt/profile http://localhost:58149/getInfo.html) 08:04:17 INFO - PROCESS | 23087 | __metrics Screen width/height:1600/1200 08:04:17 INFO - PROCESS | 23087 | colorDepth:24 08:04:17 INFO - PROCESS | 23087 | Browser inner width/height: 1024/697 08:04:17 INFO - PROCESS | 23087 | __metrics 08:04:17 ERROR - PROCESS | 23087 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 08:04:18 INFO - TEST-INFO | 23087: exit 0 08:04:18 INFO - Browser initialized. 08:04:18 INFO - Running cycle 1/1 for kraken test... 08:04:18 INFO - TEST-INFO | started process 23210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY2XCFt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:04:31 INFO - PROCESS | 23210 | RSS: Main: 187658240 08:04:31 INFO - PROCESS | 23210 | 08:04:34 INFO - PROCESS | 23210 | Cycle 1(1): loaded http://localhost:58149/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58149/tests/kraken/driver.html?testName=audio-beat-detection) 08:04:35 INFO - PROCESS | 23210 | RSS: Main: 200462336 08:04:35 INFO - PROCESS | 23210 | 08:04:38 INFO - PROCESS | 23210 | Cycle 1(1): loaded http://localhost:58149/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58149/tests/kraken/driver.html?testName=audio-dft) 08:04:38 INFO - PROCESS | 23210 | RSS: Main: 198123520 08:04:38 INFO - PROCESS | 23210 | 08:04:41 INFO - PROCESS | 23210 | Cycle 1(1): loaded http://localhost:58149/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58149/tests/kraken/driver.html?testName=audio-fft) 08:04:42 INFO - PROCESS | 23210 | RSS: Main: 195219456 08:04:42 INFO - PROCESS | 23210 | 08:04:44 INFO - PROCESS | 23210 | Cycle 1(1): loaded http://localhost:58149/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58149/tests/kraken/driver.html?testName=audio-oscillator) 08:04:45 INFO - PROCESS | 23210 | RSS: Main: 195698688 08:04:45 INFO - PROCESS | 23210 | 08:04:47 INFO - PROCESS | 23210 | Cycle 1(1): loaded http://localhost:58149/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58149/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:04:47 INFO - PROCESS | 23210 | RSS: Main: 195854336 08:04:47 INFO - PROCESS | 23210 | 08:04:51 INFO - PROCESS | 23210 | Cycle 1(1): loaded http://localhost:58149/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58149/tests/kraken/driver.html?testName=imaging-darkroom) 08:04:51 INFO - PROCESS | 23210 | RSS: Main: 200667136 08:04:51 INFO - PROCESS | 23210 | 08:04:55 INFO - PROCESS | 23210 | Cycle 1(1): loaded http://localhost:58149/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58149/tests/kraken/driver.html?testName=imaging-desaturate) 08:04:55 INFO - PROCESS | 23210 | RSS: Main: 197005312 08:04:55 INFO - PROCESS | 23210 | 08:04:58 INFO - PROCESS | 23210 | Cycle 1(1): loaded http://localhost:58149/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58149/tests/kraken/driver.html?testName=json-parse-financial) 08:04:59 INFO - PROCESS | 23210 | RSS: Main: 198496256 08:04:59 INFO - PROCESS | 23210 | 08:05:01 INFO - PROCESS | 23210 | Cycle 1(1): loaded http://localhost:58149/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58149/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:05:01 INFO - PROCESS | 23210 | RSS: Main: 198733824 08:05:01 INFO - PROCESS | 23210 | 08:05:03 INFO - PROCESS | 23210 | Cycle 1(1): loaded http://localhost:58149/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58149/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:05:04 INFO - PROCESS | 23210 | RSS: Main: 198877184 08:05:04 INFO - PROCESS | 23210 | 08:05:06 INFO - PROCESS | 23210 | Cycle 1(1): loaded http://localhost:58149/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58149/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:05:07 INFO - PROCESS | 23210 | RSS: Main: 198672384 08:05:07 INFO - PROCESS | 23210 | 08:05:10 INFO - PROCESS | 23210 | Cycle 1(1): loaded http://localhost:58149/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58149/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:05:11 INFO - PROCESS | 23210 | RSS: Main: 198737920 08:05:11 INFO - PROCESS | 23210 | 08:05:14 INFO - PROCESS | 23210 | Cycle 1(1): loaded http://localhost:58149/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58149/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:05:14 INFO - PROCESS | 23210 | RSS: Main: 198742016 08:05:14 INFO - PROCESS | 23210 | 08:05:16 INFO - PROCESS | 23210 | Cycle 1(1): loaded http://localhost:58149/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58149/tests/kraken/driver.html?testName=ai-astar) 08:05:16 INFO - PROCESS | 23210 | RSS: Main: 202018816 08:05:16 INFO - PROCESS | 23210 | 08:05:16 INFO - PROCESS | 23210 | __start_tp_report 08:05:16 INFO - PROCESS | 23210 | _x_x_mozilla_page_load 08:05:16 INFO - PROCESS | 23210 | _x_x_mozilla_page_load_details 08:05:16 INFO - PROCESS | 23210 | |i|pagename|runs| 08:05:16 INFO - PROCESS | 23210 | |0;ai-astar;110;118;120;117;117;120;117;117;116;117 08:05:16 INFO - PROCESS | 23210 | |1;audio-beat-detection;162;135;136;179;138;137;137;140;160;132 08:05:16 INFO - PROCESS | 23210 | |2;audio-dft;189;166;163;166;163;165;163;164;164;163 08:05:16 INFO - PROCESS | 23210 | |3;audio-fft;76;78;77;115;78;77;80;79;110;77 08:05:16 INFO - PROCESS | 23210 | |4;audio-oscillator;84;84;122;83;83;83;103;84;84;113 08:05:16 INFO - PROCESS | 23210 | |5;imaging-gaussian-blur;117;118;123;119;118;119;119;118;121;119 08:05:16 INFO - PROCESS | 23210 | |6;imaging-darkroom;149;150;151;150;147;150;149;149;149;148 08:05:16 INFO - PROCESS | 23210 | |7;imaging-desaturate;97;96;96;96;96;95;96;97;95;96 08:05:16 INFO - PROCESS | 23210 | |8;json-parse-financial;65;65;65;63;64;65;70;66;65;64 08:05:16 INFO - PROCESS | 23210 | |9;json-stringify-tinderbox;69;66;65;66;66;66;68;67;66;67 08:05:16 INFO - PROCESS | 23210 | |10;stanford-crypto-aes;87;85;86;88;85;86;86;86;86;86 08:05:16 INFO - PROCESS | 23210 | |11;stanford-crypto-ccm;146;145;158;152;151;146;149;156;187;144 08:05:16 INFO - PROCESS | 23210 | |12;stanford-crypto-pbkdf2;191;190;177;181;181;178;177;178;178;181 08:05:16 INFO - PROCESS | 23210 | |13;stanford-crypto-sha256-iterative;71;71;71;71;70;71;73;69;76;69 08:05:16 INFO - PROCESS | 23210 | __end_tp_report 08:05:16 INFO - PROCESS | 23210 | __start_cc_report 08:05:16 INFO - PROCESS | 23210 | _x_x_mozilla_cycle_collect,898 08:05:16 INFO - PROCESS | 23210 | __end_cc_report 08:05:16 INFO - PROCESS | 23210 | __startTimestamp1479830716858__endTimestamp 08:05:16 INFO - PROCESS | 23210 | 08:05:16 INFO - PROCESS | 23210 | ------- Summary: start ------- 08:05:16 INFO - PROCESS | 23210 | Number of tests: 14 08:05:16 INFO - PROCESS | 23210 | 08:05:16 INFO - PROCESS | 23210 | [#0] ai-astar Cycles:10 Average:116.90 Median:117.00 stddev:2.77 (2.4%) stddev-sans-first:1.41 08:05:16 INFO - PROCESS | 23210 | Values: 110.0 118.0 120.0 117.0 117.0 120.0 117.0 117.0 116.0 117.0 08:05:16 INFO - PROCESS | 23210 | 08:05:16 INFO - PROCESS | 23210 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:139.00 stddev:15.70 (11.3%) stddev-sans-first:15.49 08:05:16 INFO - PROCESS | 23210 | Values: 162.0 135.0 136.0 179.0 138.0 137.0 137.0 140.0 160.0 132.0 08:05:16 INFO - PROCESS | 23210 | 08:05:16 INFO - PROCESS | 23210 | [#2] audio-dft Cycles:10 Average:166.60 Median:164.50 stddev:7.96 (4.8%) stddev-sans-first:1.27 08:05:16 INFO - PROCESS | 23210 | Values: 189.0 166.0 163.0 166.0 163.0 165.0 163.0 164.0 164.0 163.0 08:05:16 INFO - PROCESS | 23210 | 08:05:16 INFO - PROCESS | 23210 | [#3] audio-fft Cycles:10 Average:84.70 Median:77.50 stddev:14.74 (19.0%) stddev-sans-first:15.30 08:05:16 INFO - PROCESS | 23210 | Values: 76.0 78.0 77.0 115.0 78.0 77.0 80.0 79.0 110.0 77.0 08:05:16 INFO - PROCESS | 23210 | 08:05:16 INFO - PROCESS | 23210 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:83.50 stddev:14.76 (17.7%) stddev-sans-first:15.34 08:05:16 INFO - PROCESS | 23210 | Values: 84.0 84.0 122.0 83.0 83.0 83.0 103.0 84.0 84.0 113.0 08:05:16 INFO - PROCESS | 23210 | 08:05:16 INFO - PROCESS | 23210 | [#5] imaging-gaussian-blur Cycles:10 Average:119.10 Median:119.00 stddev:1.73 (1.5%) stddev-sans-first:1.66 08:05:16 INFO - PROCESS | 23210 | Values: 117.0 118.0 123.0 119.0 118.0 119.0 119.0 118.0 121.0 119.0 08:05:16 INFO - PROCESS | 23210 | 08:05:16 INFO - PROCESS | 23210 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.50 stddev:1.14 (0.8%) stddev-sans-first:1.20 08:05:16 INFO - PROCESS | 23210 | Values: 149.0 150.0 151.0 150.0 147.0 150.0 149.0 149.0 149.0 148.0 08:05:16 INFO - PROCESS | 23210 | 08:05:16 INFO - PROCESS | 23210 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 08:05:16 INFO - PROCESS | 23210 | Values: 97.0 96.0 96.0 96.0 96.0 95.0 96.0 97.0 95.0 96.0 08:05:16 INFO - PROCESS | 23210 | 08:05:16 INFO - PROCESS | 23210 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.00 stddev:1.87 (2.9%) stddev-sans-first:1.99 08:05:16 INFO - PROCESS | 23210 | Values: 65.0 65.0 65.0 63.0 64.0 65.0 70.0 66.0 65.0 64.0 08:05:16 INFO - PROCESS | 23210 | 08:05:16 INFO - PROCESS | 23210 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:66.50 stddev:1.17 (1.8%) stddev-sans-first:0.87 08:05:16 INFO - PROCESS | 23210 | Values: 69.0 66.0 65.0 66.0 66.0 66.0 68.0 67.0 66.0 67.0 08:05:16 INFO - PROCESS | 23210 | 08:05:16 INFO - PROCESS | 23210 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:0.88 (1.0%) stddev-sans-first:0.87 08:05:16 INFO - PROCESS | 23210 | Values: 87.0 85.0 86.0 88.0 85.0 86.0 86.0 86.0 86.0 86.0 08:05:16 INFO - PROCESS | 23210 | 08:05:16 INFO - PROCESS | 23210 | [#11] stanford-crypto-ccm Cycles:10 Average:153.40 Median:151.50 stddev:12.70 (8.4%) stddev-sans-first:13.19 08:05:16 INFO - PROCESS | 23210 | Values: 146.0 145.0 158.0 152.0 151.0 146.0 149.0 156.0 187.0 144.0 08:05:16 INFO - PROCESS | 23210 | 08:05:16 INFO - PROCESS | 23210 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.20 Median:181.00 stddev:5.16 (2.9%) stddev-sans-first:4.08 08:05:16 INFO - PROCESS | 23210 | Values: 191.0 190.0 177.0 181.0 181.0 178.0 177.0 178.0 178.0 181.0 08:05:16 INFO - PROCESS | 23210 | 08:05:16 INFO - PROCESS | 23210 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.00 stddev:2.04 (2.9%) stddev-sans-first:2.17 08:05:16 INFO - PROCESS | 23210 | Values: 71.0 71.0 71.0 71.0 70.0 71.0 73.0 69.0 76.0 69.0 08:05:16 INFO - PROCESS | 23210 | -------- Summary: end -------- 08:05:16 INFO - PROCESS | 23210 | 08:05:17 INFO - PROCESS | 23210 | 08:05:17 INFO - PROCESS | 23210 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 08:05:17 INFO - PROCESS | 23210 | 08:05:17 INFO - PROCESS | 23210 | 08:05:17 INFO - PROCESS | 23210 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 08:05:17 INFO - PROCESS | 23210 | 08:05:17 INFO - PROCESS | 23210 | 08:05:17 INFO - PROCESS | 23210 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 08:05:17 INFO - PROCESS | 23210 | 08:05:17 INFO - PROCESS | 23210 | 08:05:17 INFO - PROCESS | 23210 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 08:05:17 INFO - PROCESS | 23210 | 08:05:17 INFO - PROCESS | 23210 | 08:05:17 INFO - PROCESS | 23210 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 08:05:17 INFO - PROCESS | 23210 | 08:05:17 INFO - TEST-INFO | 23210: exit 0 08:05:18 INFO - TEST-OK | kraken | took 65338ms 08:05:18 INFO - SUITE-END | took 1186s 08:05:18 INFO - Completed test suite (00:19:46) 08:05:18 INFO - javascript benchmark 08:05:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 5967.558389606851, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2616.8037397195208, 2617.267165193746, 2628.382330152415, 2651.6685414323206, 2663.946721065579, 4628.884277893055, 4759.3812804335475, 4788.353572267747, 4833.758312084395, 4844.103840789457, 4637.698549594274, 4668.276417155338, 4679.204535229011, 4709.340692303081, 4715.717056976584, 4298.9785051074705, 4325.653947684185, 4398.0, 4411.845585404511, 4471.306947423138, 4311.137772445508, 4361.411209486726, 4464.776761161929, 4509.165804326194, 4533.773311334437, 4246.830126794925, 4281.743095414254, 4283.764392958386, 4417.933730994037, 4422.778861056934, 4272.060146767706, 4283.229018776619, 4289.013526888802, 4297.312430011214, 4347.760873151976, 4266.445362102907, 4311.417958575584, 4318.265894797892, 4384.583464570861, 4388.210122178007, 4750.239961606161, 4765.618750499952, 4787.8646579990545, 4804.303376010494, 4829.468758436569, 5036.949630503685, 5068.2144267638205, 5145.151050076733, 5148.794048238066, 5163.225516172567, 5134.0758663440565, 5141.048905952373, 5144.948550514484, 5152.278680984665, 5185.274061631375, 4804.927926081112, 4808.759562021885, 4810.11012962603, 4828.37231159954, 4854.199057155565, 5131.358580177478, 5159.406668233126, 5163.173892177234, 5221.399539052982, 5228.215767634885, 4989.850304490871, 4999.450060493343, 5007.749612519432, 5031.924521132186, 5059.494050594911, 4912.189488734391, 4948.455669876311, 5165.14775062118, 5199.428062913076, 5237.895242095213, 4940.604751619861, 4941.703497790072, 4986.650934434628, 4999.150144475448, 5009.398872135367, 4952.603791696655, 4960.23116416956, 4962.925556116661, 4973.2042873140845, 5004.299398084271, 4240.978795106004, 4311.310190369526, 4321.762303073361, 4361.345798130305, 4379.080393117481, 3775.188334508094, 3800.5819359870393, 3826.9808650956566, 3849.634284742945, 3858.440526123696, 4411.2721400968485, 4411.823527058882, 4421.115776844644, 4434.401355816988, 4483.058557702919, 4982.153033984159, 5000.024995125988, 5019.598432125421, 5132.794688212504, 5189.040027594907, 4386.846460373871, 4447.644188464915, 4457.064016556495, 4462.308342206963, 4496.325551167286, 4622.884427889262, 4652.511486293891, 4664.137134630037, 4696.906061878812, 4723.173444647173, 4601.608863246662, 4797.544233297831, 4807.6394270429155, 4809.903801923872, 4854.757262136879, 4971.229459433794, 5028.974855125847, 5032.119379108568, 5034.84895453137, 5046.1673823818655, 4626.213543697512, 4670.392848929618, 4672.135654903854, 4677.0, 4680.7191568506, 4925.48282430354, 4976.278439626306, 5030.874228144326, 5046.9747651261505, 5059.392872855134, 5030.144875371268, 5136.460671629425, 5153.793848246029, 5159.226116082617, 5201.0, 5020.217141549872, 5020.698758074527, 5023.447420783637, 5028.34631497903, 5067.898642027212, 4830.178869592248, 4857.708537487762, 4941.382327209099, 4986.351774269322, 5022.773975171053, 4950.702957822542, 4958.42978057528, 4961.70229786214, 4963.776630051729, 4964.205727083649, 5023.0, 5044.319016932814, 5052.494750524918, 5070.923936140887, 5098.2352647103235, 4750.406199225097, 4815.3258543804595, 4831.541003604652, 4943.975280123576, 4951.356323677899], "value": 4671.017209275516, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.9407165211828, 539.9082156033476, 548.388546770351, 549.8185598752412, 556.952659023983, 28040.579391309147, 37481.625183748154, 38741.41887871684, 38980.22039559214, 42238.78880605601, 37607.62392376075, 37897.621023789754, 37945.430818537745, 37979.24041519168, 38053.42919856197, 7378.520396174258, 7495.475316727831, 7505.211952744965, 7507.924920750777, 7513.699452021912, 7431.628418579076, 7463.2163622819635, 7483.251674832501, 7519.962400187991, 7549.735759248428, 7493.925060749377, 7501.212372700869, 7508.737194198204, 7515.549067055994, 7517.135529414105, 7417.7774666759815, 7485.887711684329, 7487.438442116809, 7495.512791668524, 7495.812604684872, 7424.96287518559, 7510.1738808731, 7515.0, 7559.962200188964, 7567.432442566775, 36179.4573081404, 36512.452313215326, 36573.63426365729, 36667.0, 36854.447183292, 3041.2092855857413, 3243.4810430331036, 3340.4321265384942, 3410.28384039352, 3586.7309951753464, 26836.865815670993, 26933.595996060074, 28034.299142521395, 28164.43671126566, 28286.591362918465, 3356.63077061523, 3452.879149229765, 3478.5825700916052, 3486.564179477565, 3588.982055089708, 250253.0, 251445.0, 251717.7414112936, 251724.0, 252119.0, 48494.0, 48862.75568622134, 48878.0, 48878.26682599764, 48895.75552122216, 31256.0, 32148.83925580404, 32256.677433225836, 51303.230451543255, 51637.0, 12133.635990920286, 12362.75274494505, 12363.814542781865, 12396.194247374073, 12441.191322564004, 9179.357444978787, 9197.310201734897, 9223.815523689489, 9263.90736092644, 9272.072792720808, 17217.91391043037, 17266.395676151275, 17321.826781732023, 17401.216945237495, 17471.0, 6781.694823732944, 6814.386705196457, 6874.312568743186, 6914.792556223321, 6960.617166055916, 769.8037000564821, 936.3118108190474, 943.6272672294406, 948.2840455456087, 1011.4588695048114, 26123.608145877828, 26750.197494075208, 27147.457050859266, 27153.728462715517, 27245.0, 903.4263242840843, 903.7059916603941, 920.07992007992, 925.121134921827, 1005.1154983614518, 13832.515861944985, 13855.653608659662, 13922.09506382082, 14191.0, 14209.431622735181, 365720.0, 366818.0, 367987.0, 368052.0, 373035.0, 45356.77321613371, 45951.31073033907, 46089.0, 46101.538984609724, 46190.0, 1148.052856393462, 1166.935818529972, 1186.8753780853058, 1189.6847335456112, 1203.8374819399444, 24181.15365962183, 26255.73744262533, 28469.288267793472, 28972.13083607495, 30571.23571910631, 45254.0, 46114.769426152656, 46117.30824037575, 46123.538764613266, 46175.07649846917, 344701.0, 349534.0, 349908.0, 350989.0, 351129.0, 20541.0, 21162.894185528974, 21269.255576054762, 36030.63969360273, 36558.0, 37268.254634907695, 37904.0, 38177.618223818514, 38667.80666096652, 38703.22593548057, 32564.348713025134, 32706.34587308193, 32737.34525309528, 32867.671323286464, 33088.338233235685, 31753.0, 32399.028029159163, 32647.673523264464, 32815.0, 32883.01350959475, 31972.520412194302, 32139.0, 32231.677683222868, 33902.0, 37537.18471114623, 29663.25841853971, 30760.0, 32061.198470037503, 32423.513647295782, 32657.346853062332, 24519.0, 24575.87712061428, 24665.260042198763, 24934.0, 25163.370915727253], "value": 16751.97355561503, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.0915097868096, 347.17199479242, 350.32037846577646, 360.8177870175561, 373.5480069116369, 15319.234038298082, 16129.83870161298, 17198.914005429986, 17269.136543172855, 17300.567485812862, 15285.541433757006, 16568.337266509356, 16689.24898379573, 16708.164591770423, 16746.24641891115, 4359.564043595631, 4613.284940834176, 4632.791524381394, 4681.0, 4703.717776933395, 3497.178163131662, 4631.8147274109, 4657.06858628274, 4658.277966915133, 4671.416072990876, 3649.671529562339, 5041.8487445376695, 5250.9474905250845, 5281.498257665535, 5334.053070629231, 5166.43169251382, 5306.336707911511, 5311.814086506973, 5324.467553244664, 5332.600054995852, 5201.817936372247, 5209.973950130225, 5216.713080780555, 5216.9739151304, 5217.869553261199, 12105.273683579013, 12410.937945310216, 17880.55298617532, 19701.605967880707, 20258.189672413235, 1839.245909177231, 1890.7920128785822, 1891.7540719706487, 1932.671445854208, 2081.250749730096, 8410.36922230835, 8833.602487887996, 9037.457752534803, 9342.57958391874, 9399.57701903416, 1611.113887361958, 1641.4829328761402, 1708.9743653845203, 1710.9657806843793, 1737.1574786228668, 59062.704686476725, 60792.603698150924, 70780.0, 71760.0, 72130.63934680345, 8076.636551355203, 8600.182982616641, 8738.825223495494, 8775.868361974575, 9809.027343925722, 11247.325160490396, 11252.324860508395, 11287.322760634388, 11314.264572802742, 11382.032527235278, 6098.115773212948, 6119.2350956130485, 6285.402886725754, 6345.460635846005, 6350.936490635127, 5833.183354330397, 5890.204822349014, 5972.701364931736, 5979.970100149471, 6069.696515174312, 3416.8633254669535, 3442.2599141184764, 3452.223249768782, 3463.5324231228965, 3508.9122771930397, 1767.5227688524026, 1795.985268323393, 1834.8715589908845, 1851.6944704123669, 1853.2957476159243, 364.4005610770268, 371.8494009925984, 385.1238432565879, 385.56623798226997, 396.843246917466, 10518.684439466828, 10903.236773425784, 10918.727031824268, 10919.235653504338, 10976.0, 397.00504962562775, 397.67986770649327, 404.75310060862853, 415.5968710350955, 417.7848408069846, 5338.412774594792, 5376.946230537645, 5558.110702287615, 5621.8594535136945, 5680.091185410314, 406363.0, 406462.0, 408517.0, 413634.0, 414933.0, 79035.60482197552, 80111.0, 82016.58991705003, 83860.58069709613, 86105.56947215224, 406.0397160714888, 415.146873175627, 416.1427459433576, 416.7083041870642, 417.3406018490777, 9993.700188994342, 10169.84745228837, 10275.794484110425, 14156.575302740934, 15738.370465181264, 36496.27007459889, 36601.0, 37214.62785372112, 37498.81250593839, 38573.80713096417, 47802.28296575484, 47868.0, 48066.27900581424, 48126.759366204344, 49053.0, 6844.794656160323, 6981.3367730065565, 7370.96314518424, 7584.2794934481135, 7679.616019199129, 10258.692239232834, 11371.090312774793, 11622.0702343814, 11665.708357291136, 11680.299182049104, 9462.290328225274, 9847.458389788344, 9918.801623967336, 9945.751356216153, 9980.850287245843, 10103.595856165672, 10124.392536447836, 10261.58953641846, 10335.896641033494, 10390.844137338097, 9989.700308990741, 10044.196464282986, 10048.949755251177, 10501.842472363074, 10617.787644247226, 7527.096748390229, 7620.428467864822, 7623.542587444771, 7726.956860823717, 7754.596075216701, 9645.614175433186, 10285.331453455501, 10311.0, 10419.479026048819, 10707.089897358812], "value": 7069.419180393355, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.1807088640487, 1358.1307962903743, 1416.914985100894, 1572.3396173607084, 1614.580209145622, 5750.252467179261, 5933.643981361121, 6297.779577714781, 6742.224644165916, 6845.041694162821, 6286.402791734778, 6559.868802623944, 6576.210854697431, 6633.668316584176, 6711.899321510181, 1963.96072078558, 2025.4733769220036, 2031.187524990001, 2031.806978337063, 2038.5005673609987, 1987.4534503011644, 2040.0513761101085, 2040.9591808163827, 2042.5200077981663, 2046.1713006232499, 1949.0741897598598, 1966.7246585478044, 1968.9901550492227, 1989.8359459716085, 1992.721019057333, 1955.2081407030105, 1975.4271261334195, 1975.6147551227516, 1976.3675623800389, 1979.475439008664, 1949.8440124789984, 1957.5986922680815, 1966.0, 1998.510364960594, 2002.819746222847, 6710.93289067108, 6759.9522074078595, 6791.4227290679855, 6800.829979250509, 6835.213950395669, 3932.46911666927, 4055.8174882130374, 4057.756534607933, 4058.269511487931, 4061.5938406159444, 2619.266605350505, 2717.388587567801, 2773.459175460786, 2791.776657867366, 2800.8739606717745, 844.4806444036934, 863.0721973878043, 889.9911000889973, 898.4384759525296, 905.6830109461636, 7960.203979602052, 8414.0, 8521.44610600309, 8731.170538798804, 8780.034196238472, 3308.2225676965895, 3381.2730262993573, 3453.689167974894, 3463.6709512596262, 3479.373712731682, 7050.048243487064, 7050.330218629222, 7058.223595404502, 7060.188078371053, 7068.081149450539, 4008.3386241270446, 4014.6788256939376, 4017.5982401760175, 4019.2363450944226, 4023.8189281482405, 3248.13924310058, 3354.5974483062187, 3609.9278014439565, 3761.360568703327, 3773.415120656303, 2819.182437093261, 2852.3867368515866, 2917.4311009353396, 2944.985275073611, 2973.687762784876, 890.7773056735816, 895.6283142495791, 902.837489251941, 905.4069584422082, 907.26964793342, 691.180950573572, 798.6685525506849, 839.5466448117947, 847.7626264645909, 859.4456575508761, 4638.95361046392, 4785.210440277385, 4859.465458799529, 4889.3888263967, 5147.897042059138, 405.3514376996782, 405.5640186799144, 406.6482492643901, 408.3996525108146, 409.44929070400264, 3226.1934516370907, 3407.4037043517783, 3517.120719820045, 3521.4189658706537, 3641.8543258269374, 7726.497777644435, 8061.193880612009, 8068.7175948841505, 8069.83860322802, 8075.87886181696, 8041.075276343296, 8062.798430039296, 8065.314448271963, 8065.435419520577, 8083.030036395553, 6341.143945567289, 6352.396522330371, 6428.871422571522, 6430.710618022294, 6489.805305840832, 4662.766861656835, 4696.835610753607, 4781.42622885256, 4786.44955830084, 4879.072976134523, 7155.356017958408, 7168.53404528704, 7233.927660723325, 7288.0, 7300.598467084362, 7299.8540029200185, 7300.744473943387, 7324.267573242633, 7385.889211661722, 7391.630418478947, 4971.37857767779, 5664.745086471036, 5671.404502527175, 5699.48963524658, 5715.257016587817, 5756.1941328214925, 6160.353162917829, 6297.716602752978, 6308.243010838729, 6427.389398007182, 5812.273465816773, 5818.592698511064, 5831.766729330949, 5906.911396329145, 5910.290765108214, 5750.971245143747, 5763.510101641407, 5782.710864456844, 5816.302043754607, 5851.385604511465, 5408.13469844823, 5416.783328666967, 5417.83746487606, 5477.342718873601, 5578.414266502121, 4064.4919385076864, 4133.23535145999, 4169.395437661583, 4269.188854117708, 4447.466304043535, 4039.6970227233664, 4102.91794164121, 4163.0, 4249.277622804069, 4356.607905288539], "value": 3546.7944609889223, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.76836609796914, 284.36160818961434, 292.65466749235907, 292.80089539113396, 300.3752195433496, 4835.9274610880775, 4883.951160488394, 4980.203167493201, 4989.426215985162, 4994.575461085812, 4766.78549465274, 4900.509949005098, 4917.4099108107075, 4917.557419832215, 4919.409670839495, 3802.6500592289754, 3841.5390153181656, 3846.0577658091584, 3846.499955005845, 3854.286956912966, 3600.4419315006085, 3833.367494363427, 3838.309104361214, 3866.76799392036, 3870.7677539347587, 3735.8692445764405, 3773.9433908491396, 3777.7922214278206, 3788.9918343278105, 3789.147441825581, 3749.381352076904, 3763.1909139534996, 3770.6983441324764, 3776.811159442017, 3778.0, 3108.875644974198, 3171.31816659417, 3180.491121420585, 3286.408446479633, 3294.357600267949, 4779.733370656779, 4794.976025119852, 4795.808167673289, 4800.591949684281, 4805.543473370024, 4245.214635292481, 4258.212230737293, 4258.61672449481, 4259.787010649455, 4278.315469524861, 4964.429090654585, 5091.66904151229, 5097.541221290065, 5109.6167787415725, 5128.538431541142, 3467.6705712957482, 3502.6689857854108, 3517.7537572369943, 3526.1537231064617, 3528.400171970771, 5401.972990135064, 5403.78384864605, 5408.648437851566, 5415.6479828811, 5423.891522169574, 3544.7742554275487, 3545.2200515886466, 3550.627184145679, 3553.218291975761, 3562.98218508911, 3425.143714071482, 3606.7655602386285, 3623.8188090595363, 3638.181409182913, 3650.8904732858055, 4204.306289462204, 4206.3690446432665, 4209.431726716915, 4213.346931225665, 4267.4025636410925, 5116.667416617908, 5128.79484820603, 5136.948630513722, 5185.792568297225, 5204.583633309327, 1175.9470823812778, 1182.7161481244439, 1222.706550427891, 1235.2897084176454, 1241.490988694631, 796.1520980156231, 819.1071731812353, 819.1112642782529, 822.621594066736, 830.1947111302028, 4314.439122914064, 4326.394304797331, 4341.370501277297, 4349.217140914666, 4379.321205213197, 5099.0, 5104.183330667075, 5105.9744701276995, 5107.361579802525, 5128.307678463434, 4353.782310884443, 4377.942367087464, 4384.6273066789045, 4392.2094023075515, 4399.252127138394, 2645.4973555024485, 2699.838009719423, 2708.390612112259, 2713.710987281065, 2737.534619114755, 4741.364229340872, 4744.572988431058, 4749.907521270127, 4759.405074365704, 4776.641751868624, 5026.271190677331, 5184.611154163453, 5263.0, 5295.311609490742, 5331.253624492574, 4610.008848097675, 4717.905641887143, 4738.194506933898, 4742.430908291027, 4787.133018122865, 5018.3977922648055, 5084.322173682602, 5098.745062746773, 5105.030044291572, 5155.304033955368, 4887.706737595756, 4952.182889823139, 4952.57903078228, 4974.278729584263, 4983.526564976321, 4572.382728331632, 4742.359781429601, 4745.572898439157, 4761.595264402426, 4766.61867050642, 3500.789952602852, 3512.5960514541157, 3514.314708631792, 3514.876979305712, 3556.8399422025554, 5144.588432925282, 5201.505856943584, 5209.739513024258, 5210.889589716171, 5230.320058392384, 4629.712903838178, 5128.974355128201, 5135.948640513697, 5154.433012368711, 5154.716490593053, 5132.845109850254, 5135.3324067870935, 5146.841960558844, 5147.716875571879, 5158.484151584961, 4888.291197776373, 5102.43873173958, 5104.719240441663, 5126.923096153635, 5153.4073581538605, 5213.478652134756, 5224.947750522446, 5229.346331708536, 5235.973820130875, 5241.659292145999, 5118.155504341742, 5119.795208191631, 5122.206058061007, 5137.640365174402, 5148.922766158586], "value": 3776.6926305517427, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.5983760149907, 647.1522305779426, 660.3165723476203, 730.4120183252479, 742.4728442805609, 12404.069694772894, 13441.0, 13464.596062118128, 13485.325733713324, 13511.121777084483, 12474.625761227155, 12551.246925184496, 12580.68548286291, 12634.747305053894, 12635.115541912046, 619.7459041792865, 637.7130291368879, 751.7519218657857, 766.4022062791004, 778.9727359542388, 763.2138896936165, 781.0744268042388, 783.5181363461459, 783.7413653494333, 785.3756263770288, 826.2192228344217, 829.2992421403904, 831.1314676163394, 831.9808234912215, 832.6919039955225, 822.411975437562, 823.472977294532, 824.7113510271417, 825.4098319701442, 825.8183199696057, 611.3916652930318, 614.1463365921372, 614.8309214965875, 615.1203778596605, 615.157234588612, 12742.61772146837, 12802.231866088065, 12954.157979731288, 13001.414936327794, 13007.609771706864, 12321.568745093879, 12823.807642885364, 12885.871141288655, 13048.739025219442, 13236.602901912958, 9826.410415375029, 9835.393620690522, 9926.702198934043, 9991.250656200742, 10053.346532475365, 3155.179653290138, 3213.678632136791, 3241.789283696552, 3351.8826841060445, 3355.865765369382, 54095.0, 54365.72817135928, 54523.727381363235, 54603.453965460234, 56213.156802647994, 9747.951260243653, 9910.20718342531, 9918.305718599773, 10132.138768204784, 10464.319819211727, 15812.36750529989, 18908.243670253036, 19066.904665476584, 19074.52313692141, 19111.52221194481, 6409.487241020707, 6485.77299794505, 6566.277709451956, 6585.604863708097, 6710.664466776641, 3428.5371474850576, 3491.493733408692, 3549.662782035754, 3554.4668299755244, 3637.8726744563814, 2819.4643017826547, 2849.700781417963, 2905.709429057077, 2907.9854600726862, 2909.2145120817263, 479.82486392467194, 481.0787342239572, 483.3860996534382, 484.3388774323094, 489.67926008464514, 520.7344254430268, 523.1838332201702, 543.8667526456044, 584.3163498706524, 606.8816580766796, 7265.0, 7315.817104572322, 7481.625918704043, 7573.166951635316, 7573.242675732383, 576.6453631016979, 589.1869220475802, 591.4913174669781, 591.9171316015761, 595.2707932782394, 3361.8991430257133, 3412.3004784019217, 3424.279354341274, 3575.8927232183078, 3578.141246100969, 39388.0, 53942.7302863491, 55978.0, 56427.0, 61197.0, 40308.59691403049, 45317.32024019642, 64257.0, 64705.35294647088, 64896.0, 45002.54997450049, 57812.0, 58403.4159658398, 60490.092648609425, 61356.386436136854, 7466.178720340867, 7802.960985195038, 7822.843543129219, 7899.723509677134, 8033.7188198415115, 38798.80600596979, 39496.60503395044, 39551.60448395594, 39575.80212098921, 40425.39361909515, 49300.75349623229, 49418.50581494139, 51126.23310650417, 53197.46802531925, 55558.72220638871, 11271.211015228855, 11445.542178312775, 11538.82691759641, 11650.825237621611, 12371.13402061847, 11766.0, 12063.577774777841, 12257.14200005991, 12257.325847078497, 12369.62891113268, 10588.417637030037, 11118.444077796239, 11192.552297907992, 11429.085673146295, 11513.597024104116, 10463.372197668165, 10585.311954722918, 10748.247622666338, 11260.718482038015, 11457.942710286396, 10080.445575493419, 10152.23858210652, 10562.049415552638, 11119.944400277947, 11309.547618095514, 9074.911010678497, 9294.628214871329, 9409.717708468757, 9538.666146684833, 9958.302918795614, 9217.262618990331, 9606.66376676813, 9878.4566848824, 9911.157551607906, 9916.702498925044], "value": 6094.230191743296, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1594.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 118.0, 120.0, 117.0, 117.0, 120.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 135.0, 136.0, 179.0, 138.0, 137.0, 137.0, 140.0, 160.0, 132.0], "value": 145.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 166.0, 163.0, 166.0, 163.0, 165.0, 163.0, 164.0, 164.0, 163.0], "value": 166.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 115.0, 78.0, 77.0, 80.0, 79.0, 110.0, 77.0], "value": 84.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 122.0, 83.0, 83.0, 83.0, 103.0, 84.0, 84.0, 113.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 123.0, 119.0, 118.0, 119.0, 119.0, 118.0, 121.0, 119.0], "value": 119.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 151.0, 150.0, 147.0, 150.0, 149.0, 149.0, 149.0, 148.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 63.0, 64.0, 65.0, 70.0, 66.0, 65.0, 64.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 65.0, 66.0, 66.0, 66.0, 68.0, 67.0, 66.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 88.0, 85.0, 86.0, 86.0, 86.0, 86.0, 86.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 158.0, 152.0, 151.0, 146.0, 149.0, 156.0, 187.0, 144.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 190.0, 177.0, 181.0, 181.0, 178.0, 177.0, 178.0, 178.0, 181.0], "value": 181.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 71.0, 71.0, 70.0, 71.0, 73.0, 69.0, 76.0, 69.0], "value": 71.2, "unit": "score"}]}]} 08:05:18 INFO - Return code: 0 08:05:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:05:18 ERROR - # TBPL SUCCESS # 08:05:18 INFO - Running post-action listener: _resource_record_post_action 08:05:18 INFO - [mozharness: 2016-11-22 16:05:18.148126Z] Finished run-tests step (success) 08:05:18 INFO - Running post-run listener: _resource_record_post_run 08:05:18 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400642048; Read time: 8; Write time: 241760 08:05:18 INFO - TinderboxPrint: CPU usage
13.5% 08:05:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:05:18 INFO - TinderboxPrint: I/O write bytes / time
400,642,048 / 241,760 08:05:18 INFO - TinderboxPrint: CPU idle
8,300.5 (86.5%) 08:05:18 INFO - TinderboxPrint: CPU user
1,232.4 (12.8%) 08:05:18 INFO - TinderboxPrint: Swap in / out
0 / 0 08:05:18 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109977600; Read time: 0; Write time: 59860 08:05:18 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289767424; Read time: 8; Write time: 181876 08:05:18 INFO - Running post-run listener: _upload_blobber_files 08:05:18 INFO - Blob upload gear active. 08:05:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:05:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:05:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:05:19 INFO - (blobuploader) - INFO - Open directory for files ... 08:05:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:05:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:05:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:23 INFO - (blobuploader) - INFO - Done attempting. 08:05:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:05:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:05:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:24 INFO - (blobuploader) - INFO - Done attempting. 08:05:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:05:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:05:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:26 INFO - (blobuploader) - INFO - Done attempting. 08:05:26 INFO - (blobuploader) - INFO - Iteration through files over. 08:05:26 INFO - Return code: 0 08:05:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:05:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:05:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/eca42de5eca95c5e160b1ea81946d70137ec8db026a25db2ee864e2395bd15ab5253c7fe60c48cd517fc9a84426a6899b17b550e1367f2aa1419adb7b747f82c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0cc4f7b4889c1de9248f6c71c7e4f37320ba9c1c87b205852c78b167ba8011d58472f65f58134192de3a6b0dbe28d64656db060898445c3d1d663d36003b8c87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/567710b02d24e4bf59986edd50cfaf3e4f74e4c957c6079a9b9065f56ddf959dbdd4432e7280800af211dd3282c46db7ace43e5a526db09a319fb82e1ba6ae35"} 08:05:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:05:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:05:26 INFO - Contents: 08:05:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/eca42de5eca95c5e160b1ea81946d70137ec8db026a25db2ee864e2395bd15ab5253c7fe60c48cd517fc9a84426a6899b17b550e1367f2aa1419adb7b747f82c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0cc4f7b4889c1de9248f6c71c7e4f37320ba9c1c87b205852c78b167ba8011d58472f65f58134192de3a6b0dbe28d64656db060898445c3d1d663d36003b8c87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/567710b02d24e4bf59986edd50cfaf3e4f74e4c957c6079a9b9065f56ddf959dbdd4432e7280800af211dd3282c46db7ace43e5a526db09a319fb82e1ba6ae35"} 08:05:26 INFO - Running post-run listener: copy_logs_to_upload_dir 08:05:26 INFO - Copying logs to upload dir... 08:05:26 INFO - mkdir: /builds/slave/test/build/upload/logs 08:05:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.009167 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-22 08:05:26.159723) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 08:05:26.163209) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/eca42de5eca95c5e160b1ea81946d70137ec8db026a25db2ee864e2395bd15ab5253c7fe60c48cd517fc9a84426a6899b17b550e1367f2aa1419adb7b747f82c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0cc4f7b4889c1de9248f6c71c7e4f37320ba9c1c87b205852c78b167ba8011d58472f65f58134192de3a6b0dbe28d64656db060898445c3d1d663d36003b8c87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/567710b02d24e4bf59986edd50cfaf3e4f74e4c957c6079a9b9065f56ddf959dbdd4432e7280800af211dd3282c46db7ace43e5a526db09a319fb82e1ba6ae35"} build_url:https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011478 build_url: 'https://queue.taskcluster.net/v1/task/HcL_grkqTdKm0DFrtq4KiQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/eca42de5eca95c5e160b1ea81946d70137ec8db026a25db2ee864e2395bd15ab5253c7fe60c48cd517fc9a84426a6899b17b550e1367f2aa1419adb7b747f82c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0cc4f7b4889c1de9248f6c71c7e4f37320ba9c1c87b205852c78b167ba8011d58472f65f58134192de3a6b0dbe28d64656db060898445c3d1d663d36003b8c87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/567710b02d24e4bf59986edd50cfaf3e4f74e4c957c6079a9b9065f56ddf959dbdd4432e7280800af211dd3282c46db7ace43e5a526db09a319fb82e1ba6ae35"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 08:05:26.188892) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 08:05:26.189239) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1479826782.248789-809592942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 08:05:26.272556) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 08:05:26.272889) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 08:05:26.273195) ========= ========= Total master_lag: 0.17 =========