builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1480266638.03 results: success (0) buildid: 20161127063011 builduid: cefea6d14606405db377176f8954b932 revision: c17948ef9b358c38d267032dc7667142e8c08909 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-27 09:10:38.033787) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-27 09:10:38.034431) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-27 09:10:38.034917) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-27 09:10:38.050932) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 09:10:38.051428) ========= 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=52faae308a556c440401f8e5000001e8-1480255321.703855-417090065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-27 09:10:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-11-27 09:10:42 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114064 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 09:10:38.189069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 09:10:38.189586) ========= 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=52faae308a556c440401f8e5000001e8-1480255321.703855-417090065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020368 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 09:10:38.245226) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-27 09:10:38.245928) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c17948ef9b358c38d267032dc7667142e8c08909 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c17948ef9b358c38d267032dc7667142e8c08909 --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=52faae308a556c440401f8e5000001e8-1480255321.703855-417090065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-27 09:10:43,020 truncating revision to first 12 chars 2016-11-27 09:10:43,020 Setting DEBUG logging. 2016-11-27 09:10:43,020 attempt 1/10 2016-11-27 09:10:43,020 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c17948ef9b35?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-27 09:10:44,048 unpacking tar archive at: mozilla-inbound-c17948ef9b35/testing/mozharness/ program finished with exit code 0 elapsedTime=1.339305 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-27 09:10:39.609009) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-27 09:10:39.609794) ========= script_repo_revision: c17948ef9b358c38d267032dc7667142e8c08909 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-27 09:10:39.610817) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-27 09:10:39.611530) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-27 09:10:39.621967) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-11-27 09:10:39.622645) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=52faae308a556c440401f8e5000001e8-1480255321.703855-417090065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:10:44 INFO - MultiFileLogger online at 20161127 09:10:44 in /builds/slave/test 09:10:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:10:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:10:44 INFO - {'append_to_log': False, 09:10:44 INFO - 'base_work_dir': '/builds/slave/test', 09:10:44 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:10:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:10:44 INFO - 'branch': 'Mozilla-Inbound', 09:10:44 INFO - 'buildbot_json_path': 'buildprops.json', 09:10:44 INFO - 'config_files': ('talos/linux_config.py',), 09:10:44 INFO - 'default_actions': ('clobber', 09:10:44 INFO - 'read-buildbot-config', 09:10:44 INFO - 'download-and-extract', 09:10:44 INFO - 'populate-webroot', 09:10:44 INFO - 'create-virtualenv', 09:10:44 INFO - 'install', 09:10:44 INFO - 'run-tests'), 09:10:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:10:44 INFO - 'download_minidump_stackwalk': True, 09:10:44 INFO - 'download_symbols': 'ondemand', 09:10:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:10:44 INFO - 'tooltool.py': '/tools/tooltool.py', 09:10:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:10:44 INFO - '/tools/misc-python/virtualenv.py')}, 09:10:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:10:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:10:44 INFO - 'installer_path': 'installer.exe', 09:10:44 INFO - 'log_level': 'info', 09:10:44 INFO - 'log_name': 'talos', 09:10:44 INFO - 'log_to_console': True, 09:10:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:10:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:10:44 INFO - 'opt_config_files': (), 09:10:44 INFO - 'pip_index': False, 09:10:44 INFO - 'sps_profile': False, 09:10:44 INFO - 'sps_profile_interval': 0, 09:10:44 INFO - 'suite': 'dromaeojs-e10s', 09:10:44 INFO - 'system_bits': '32', 09:10:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:10:44 INFO - 'title': 'talos-linux64-ix-056', 09:10:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:10:44 INFO - 'use_talos_json': True, 09:10:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:10:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:10:44 INFO - 'work_dir': 'build'} 09:10:44 INFO - [mozharness: 2016-11-27 17:10:44.499716Z] Running clobber step. 09:10:44 INFO - Running pre-action listener: _resource_record_pre_action 09:10:44 INFO - Running main action method: clobber 09:10:44 INFO - rmtree: /builds/slave/test/build 09:10:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:10:44 INFO - Running post-action listener: _resource_record_post_action 09:10:44 INFO - [mozharness: 2016-11-27 17:10:44.970039Z] Finished clobber step (success) 09:10:44 INFO - [mozharness: 2016-11-27 17:10:44.970139Z] Running read-buildbot-config step. 09:10:44 INFO - Running pre-action listener: _resource_record_pre_action 09:10:44 INFO - Running main action method: read_buildbot_config 09:10:44 INFO - Using buildbot properties: 09:10:44 INFO - { 09:10:44 INFO - "project": "", 09:10:44 INFO - "product": "firefox", 09:10:44 INFO - "script_repo_revision": "production", 09:10:44 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 09:10:44 INFO - "repository": "", 09:10:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 09:10:44 INFO - "buildid": "20161127063011", 09:10:44 INFO - "pgo_build": "True", 09:10:44 INFO - "basedir": "/builds/slave/test", 09:10:44 INFO - "buildnumber": 1948, 09:10:44 INFO - "slavename": "talos-linux64-ix-056", 09:10:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:10:44 INFO - "platform": "ubuntu64_hw", 09:10:44 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:10:44 INFO - "branch": "mozilla-inbound", 09:10:44 INFO - "repo_path": "integration/mozilla-inbound", 09:10:44 INFO - "revision": "c17948ef9b358c38d267032dc7667142e8c08909", 09:10:44 INFO - "stage_platform": "linux64-pgo", 09:10:44 INFO - "builduid": "cefea6d14606405db377176f8954b932", 09:10:44 INFO - "slavebuilddir": "test" 09:10:44 INFO - } 09:10:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 09:10:44 INFO - Running post-action listener: _resource_record_post_action 09:10:44 INFO - [mozharness: 2016-11-27 17:10:44.972588Z] Finished read-buildbot-config step (success) 09:10:44 INFO - [mozharness: 2016-11-27 17:10:44.972676Z] Running download-and-extract step. 09:10:44 INFO - Running pre-action listener: _resource_record_pre_action 09:10:44 INFO - Running main action method: download_and_extract 09:10:44 INFO - mkdir: /builds/slave/test/build/tests 09:10:44 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')]} 09:10:44 INFO - trying https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:10:44 INFO - Downloading https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/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 09:10:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/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 09:10:45 INFO - Downloaded 1361 bytes. 09:10:45 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:10:45 INFO - Using the following test package requirements: 09:10:45 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:10:45 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:10:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:10:45 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:10:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:10:45 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:10:45 INFO - u'jsshell-linux-x86_64.zip'], 09:10:45 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:10:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:10:45 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:10:45 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:10:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:10:45 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:10:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:10:45 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:10:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:10:45 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:10:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:10:45 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:10:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:10:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:10:45 INFO - Fetch https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:10:46 INFO - Http code: 200 09:10:46 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 09:10:46 INFO - x-amz-cf-id: l-_Eop7CawOpiS9iv0YOhvI4gHAoUEj5P8QGy8I32By41Qc3IQJ8rQ== 09:10:46 INFO - x-amz-version-id: XgMfjrkdjB1CzDpJsuOv2rcZSLbcR3Oo 09:10:46 INFO - Expected file size: 21780563 09:10:46 INFO - Obtained file size: 21780563 09:10:50 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 09:10:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:10:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:10:50 INFO - Fetch https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:10:51 INFO - Http code: 200 09:10:51 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 09:10:51 INFO - x-amz-cf-id: XkxOrueekNjH-EgyGXnMpq7h8kEfhYRGuSY0Swbgvjgsz3iwgimQzA== 09:10:51 INFO - x-amz-version-id: XgMfjrkdjB1CzDpJsuOv2rcZSLbcR3Oo 09:10:51 INFO - Expected file size: 21780563 09:10:51 INFO - Obtained file size: 21780563 09:10:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 09:10:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:10:55 INFO - Fetch https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:10:56 INFO - Http code: 200 09:10:56 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 09:10:56 INFO - x-amz-cf-id: zSOOqmw6jXZ2C_j5am4J_7iCC51hzCXVdqJ_m8pi-iBSlg16PYk0ZA== 09:10:56 INFO - x-amz-version-id: .cZ1p7tRqnJRKN0sCnTIJngcr9Qrqij0 09:10:56 INFO - Expected file size: 14409702 09:10:56 INFO - Obtained file size: 14409702 09:10:56 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')]} 09:10:56 INFO - trying https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:10:56 INFO - Downloading https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/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 09:10:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/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 09:10:57 INFO - Downloaded 59817985 bytes. 09:10:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:10:57 INFO - mkdir: /builds/slave/test/properties 09:10:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:10:57 INFO - Writing to file /builds/slave/test/properties/build_url 09:10:57 INFO - Contents: 09:10:57 INFO - build_url:https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:10:58 INFO - Running post-action listener: _resource_record_post_action 09:10:58 INFO - Running post-action listener: set_extra_try_arguments 09:10:58 INFO - [mozharness: 2016-11-27 17:10:58.582519Z] Finished download-and-extract step (success) 09:10:58 INFO - [mozharness: 2016-11-27 17:10:58.582745Z] Running populate-webroot step. 09:10:58 INFO - Running pre-action listener: _resource_record_pre_action 09:10:58 INFO - Running main action method: populate_webroot 09:10:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:10:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:10:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:10:58 INFO - '--tppagecycles', 09:10:58 INFO - '7'], 09:10:58 INFO - 'tests': ['tsvgm']}}, 09:10:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:10:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:10:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:10:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:10:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:10:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:10:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:10:58 INFO - 'talos_options': ['--disable-e10s'], 09:10:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:10:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:10:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:10:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:10:58 INFO - 'talos_options': ['--disable-e10s'], 09:10:58 INFO - 'tests': ['damp', 'tps']}, 09:10:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:10:58 INFO - 'tests': ['damp', 'tps']}, 09:10:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:10:58 INFO - 'tests': ['dromaeo_dom']}, 09:10:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:10:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:10:58 INFO - 'tests': ['basic_compositor_video']}, 09:10:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:10:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:10:58 INFO - 'tests': ['a11yr', 09:10:58 INFO - 'ts_paint', 09:10:58 INFO - 'tpaint', 09:10:58 INFO - 'sessionrestore', 09:10:58 INFO - 'sessionrestore_no_auto_restore', 09:10:58 INFO - 'tabpaint']}, 09:10:58 INFO - 'other-e10s': {'tests': ['a11yr', 09:10:58 INFO - 'ts_paint', 09:10:58 INFO - 'tpaint', 09:10:58 INFO - 'sessionrestore', 09:10:58 INFO - 'sessionrestore_no_auto_restore', 09:10:58 INFO - 'tabpaint']}, 09:10:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:10:58 INFO - 'ts_paint', 09:10:58 INFO - 'tpaint', 09:10:58 INFO - 'sessionrestore', 09:10:58 INFO - 'sessionrestore_no_auto_restore', 09:10:58 INFO - 'tabpaint']}, 09:10:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:10:58 INFO - 'ts_paint', 09:10:58 INFO - 'tpaint', 09:10:58 INFO - 'sessionrestore', 09:10:58 INFO - 'sessionrestore_no_auto_restore', 09:10:58 INFO - 'tabpaint']}, 09:10:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:10:58 INFO - 'tests': ['a11yr', 09:10:58 INFO - 'ts_paint', 09:10:58 INFO - 'tpaint', 09:10:58 INFO - 'sessionrestore', 09:10:58 INFO - 'sessionrestore_no_auto_restore', 09:10:58 INFO - 'tabpaint']}, 09:10:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:10:58 INFO - 'tests': ['a11yr', 09:10:58 INFO - 'ts_paint', 09:10:58 INFO - 'tpaint', 09:10:58 INFO - 'sessionrestore', 09:10:58 INFO - 'sessionrestore_no_auto_restore', 09:10:58 INFO - 'tabpaint']}, 09:10:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:10:58 INFO - 'tests': ['tsvgx', 09:10:58 INFO - 'tsvgr_opacity', 09:10:58 INFO - 'tart', 09:10:58 INFO - 'tscrollx', 09:10:58 INFO - 'cart', 09:10:58 INFO - 'tsvg_static']}, 09:10:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:10:58 INFO - 'tsvgr_opacity', 09:10:58 INFO - 'tart', 09:10:58 INFO - 'tscrollx', 09:10:58 INFO - 'cart', 09:10:58 INFO - 'tsvg_static']}, 09:10:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:10:58 INFO - 'talos_options': ['--disable-e10s'], 09:10:58 INFO - 'tests': ['tp5o']}, 09:10:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:10:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:10:58 INFO - 'talos_options': ['--disable-e10s', 09:10:58 INFO - '--xperf_path', 09:10:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:10:58 INFO - 'tests': ['tp5n']}, 09:10:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:10:58 INFO - 'talos_options': ['--xperf_path', 09:10:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:10:58 INFO - 'tests': ['tp5n']}}, 09:10:58 INFO - 'talos.zip': {'path': '', 09:10:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:10:58 INFO - Running post-action listener: _resource_record_post_action 09:10:58 INFO - [mozharness: 2016-11-27 17:10:58.597776Z] Finished populate-webroot step (success) 09:10:58 INFO - [mozharness: 2016-11-27 17:10:58.597868Z] Running create-virtualenv step. 09:10:58 INFO - Running pre-action listener: _resource_record_pre_action 09:10:58 INFO - Running main action method: create_virtualenv 09:10:58 INFO - Creating virtualenv /builds/slave/test/build/venv 09:10:58 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 09:10:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:10:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:10:58 INFO - Using real prefix '/usr' 09:10:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:10:59 INFO - Installing distribute.............................................................................................................................................................................................done. 09:11:01 INFO - Installing pip.................done. 09:11:01 INFO - Return code: 0 09:11:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:11:01 INFO - Reading from file tmpfile_stdout 09:11:01 INFO - Output received: 09:11:01 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) 09:11:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:11:01 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')]} 09:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:01 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')]} 09:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:01 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 0x7f87f1348e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1406b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1630fc0>, '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 0x1631ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1632350>, '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': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', '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 09:11:01 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 09:11:01 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 09:11:01 INFO - Using env: {'DISPLAY': ':0', 09:11:01 INFO - 'HOME': '/home/cltbld', 09:11:01 INFO - 'LANG': 'en_US.UTF-8', 09:11:01 INFO - 'LANGUAGE': 'en_US:en', 09:11:01 INFO - 'LOGNAME': 'cltbld', 09:11:01 INFO - 'MAIL': '/var/mail/cltbld', 09:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:01 INFO - 'MOZ_NO_REMOTE': '1', 09:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:01 INFO - 'NO_EM_RESTART': '1', 09:11:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:01 INFO - 'PWD': '/builds/slave/test', 09:11:01 INFO - 'SHELL': '/bin/bash', 09:11:01 INFO - 'SHLVL': '1', 09:11:01 INFO - 'TERM': 'linux', 09:11:01 INFO - 'TMOUT': '86400', 09:11:01 INFO - 'USER': 'cltbld', 09:11:01 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', 09:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:01 INFO - '_': '/tools/buildbot/bin/python'} 09:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:01 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 09:11:01 INFO - Cleaning up... 09:11:01 INFO - Return code: 0 09:11:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:11:01 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')]} 09:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:01 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')]} 09:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:01 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 0x7f87f1348e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1406b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1630fc0>, '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 0x1631ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1632350>, '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': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', '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 09:11:01 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 09:11:01 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 09:11:01 INFO - Using env: {'DISPLAY': ':0', 09:11:01 INFO - 'HOME': '/home/cltbld', 09:11:01 INFO - 'LANG': 'en_US.UTF-8', 09:11:01 INFO - 'LANGUAGE': 'en_US:en', 09:11:01 INFO - 'LOGNAME': 'cltbld', 09:11:01 INFO - 'MAIL': '/var/mail/cltbld', 09:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:01 INFO - 'MOZ_NO_REMOTE': '1', 09:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:01 INFO - 'NO_EM_RESTART': '1', 09:11:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:01 INFO - 'PWD': '/builds/slave/test', 09:11:01 INFO - 'SHELL': '/bin/bash', 09:11:01 INFO - 'SHLVL': '1', 09:11:01 INFO - 'TERM': 'linux', 09:11:01 INFO - 'TMOUT': '86400', 09:11:01 INFO - 'USER': 'cltbld', 09:11:01 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', 09:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:01 INFO - '_': '/tools/buildbot/bin/python'} 09:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:01 INFO - Downloading/unpacking psutil>=3.1.1 09:11:01 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 09:11:01 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 09:11:01 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 09:11:01 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 09:11:01 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 09:11:01 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 09:11:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:11:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:03 INFO - Installing collected packages: psutil 09:11:03 INFO - Running setup.py install for psutil 09:11:03 INFO - building 'psutil._psutil_linux' extension 09:11:03 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 09:11:04 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 09:11:04 INFO - building 'psutil._psutil_posix' extension 09:11:04 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 09:11:04 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 09:11:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:04 INFO - Successfully installed psutil 09:11:04 INFO - Cleaning up... 09:11:04 INFO - Return code: 0 09:11:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:11:04 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')]} 09:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:04 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')]} 09:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:04 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 0x7f87f1348e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1406b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1630fc0>, '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 0x1631ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1632350>, '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': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', '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 09:11:04 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 09:11:04 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 09:11:04 INFO - Using env: {'DISPLAY': ':0', 09:11:04 INFO - 'HOME': '/home/cltbld', 09:11:04 INFO - 'LANG': 'en_US.UTF-8', 09:11:04 INFO - 'LANGUAGE': 'en_US:en', 09:11:04 INFO - 'LOGNAME': 'cltbld', 09:11:04 INFO - 'MAIL': '/var/mail/cltbld', 09:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:04 INFO - 'MOZ_NO_REMOTE': '1', 09:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:04 INFO - 'NO_EM_RESTART': '1', 09:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:04 INFO - 'PWD': '/builds/slave/test', 09:11:04 INFO - 'SHELL': '/bin/bash', 09:11:04 INFO - 'SHLVL': '1', 09:11:04 INFO - 'TERM': 'linux', 09:11:04 INFO - 'TMOUT': '86400', 09:11:04 INFO - 'USER': 'cltbld', 09:11:04 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', 09:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:04 INFO - '_': '/tools/buildbot/bin/python'} 09:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:11:04 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 09:11:04 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 09:11:04 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 09:11:04 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 09:11:04 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 09:11:04 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 09:11:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:11:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:11:06 INFO - Installing collected packages: mozsystemmonitor 09:11:06 INFO - Running setup.py install for mozsystemmonitor 09:11:06 INFO - Successfully installed mozsystemmonitor 09:11:06 INFO - Cleaning up... 09:11:06 INFO - Return code: 0 09:11:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:11:06 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')]} 09:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:06 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')]} 09:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:06 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 0x7f87f1348e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1406b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1630fc0>, '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 0x1631ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1632350>, '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': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', '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 09:11:06 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 09:11:06 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 09:11:06 INFO - Using env: {'DISPLAY': ':0', 09:11:06 INFO - 'HOME': '/home/cltbld', 09:11:06 INFO - 'LANG': 'en_US.UTF-8', 09:11:06 INFO - 'LANGUAGE': 'en_US:en', 09:11:06 INFO - 'LOGNAME': 'cltbld', 09:11:06 INFO - 'MAIL': '/var/mail/cltbld', 09:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:06 INFO - 'MOZ_NO_REMOTE': '1', 09:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:06 INFO - 'NO_EM_RESTART': '1', 09:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:06 INFO - 'PWD': '/builds/slave/test', 09:11:06 INFO - 'SHELL': '/bin/bash', 09:11:06 INFO - 'SHLVL': '1', 09:11:06 INFO - 'TERM': 'linux', 09:11:06 INFO - 'TMOUT': '86400', 09:11:06 INFO - 'USER': 'cltbld', 09:11:06 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', 09:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:06 INFO - '_': '/tools/buildbot/bin/python'} 09:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:07 INFO - Downloading/unpacking jsonschema==2.5.1 09:11:07 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 09:11:07 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 09:11:07 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 09:11:07 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 09:11:07 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 09:11:07 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 09:11:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:11:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:11:08 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 09:11:08 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 09:11:08 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 09:11:08 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 09:11:08 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 09:11:08 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 09:11:09 INFO - Downloading functools32-3.2.3-2.tar.gz 09:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:11:09 INFO - warning: no files found matching '*.txt' 09:11:09 INFO - no previously-included directories found matching 'build' 09:11:09 INFO - no previously-included directories found matching 'dist' 09:11:09 INFO - no previously-included directories found matching '.git*' 09:11:09 INFO - Installing collected packages: jsonschema, functools32 09:11:09 INFO - Running setup.py install for functools32 09:11:09 INFO - warning: no files found matching '*.txt' 09:11:09 INFO - no previously-included directories found matching 'build' 09:11:09 INFO - no previously-included directories found matching 'dist' 09:11:09 INFO - no previously-included directories found matching '.git*' 09:11:09 INFO - Successfully installed jsonschema functools32 09:11:09 INFO - Cleaning up... 09:11:09 INFO - Return code: 0 09:11:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:11:09 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')]} 09:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:09 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')]} 09:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:09 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 0x7f87f1348e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1406b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1630fc0>, '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 0x1631ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1632350>, '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': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', '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 09:11:09 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 09:11:09 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 09:11:09 INFO - Using env: {'DISPLAY': ':0', 09:11:09 INFO - 'HOME': '/home/cltbld', 09:11:09 INFO - 'LANG': 'en_US.UTF-8', 09:11:09 INFO - 'LANGUAGE': 'en_US:en', 09:11:09 INFO - 'LOGNAME': 'cltbld', 09:11:09 INFO - 'MAIL': '/var/mail/cltbld', 09:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:09 INFO - 'MOZ_NO_REMOTE': '1', 09:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:09 INFO - 'NO_EM_RESTART': '1', 09:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:09 INFO - 'PWD': '/builds/slave/test', 09:11:09 INFO - 'SHELL': '/bin/bash', 09:11:09 INFO - 'SHLVL': '1', 09:11:09 INFO - 'TERM': 'linux', 09:11:09 INFO - 'TMOUT': '86400', 09:11:09 INFO - 'USER': 'cltbld', 09:11:09 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', 09:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:09 INFO - '_': '/tools/buildbot/bin/python'} 09:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:11:09 INFO - Cleaning up... 09:11:09 INFO - Return code: 0 09:11:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:11:09 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')]} 09:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:09 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')]} 09:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:09 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 0x7f87f1348e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1406b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1630fc0>, '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 0x1631ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1632350>, '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': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', '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 09:11:09 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 09:11:09 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 09:11:09 INFO - Using env: {'DISPLAY': ':0', 09:11:09 INFO - 'HOME': '/home/cltbld', 09:11:09 INFO - 'LANG': 'en_US.UTF-8', 09:11:09 INFO - 'LANGUAGE': 'en_US:en', 09:11:09 INFO - 'LOGNAME': 'cltbld', 09:11:09 INFO - 'MAIL': '/var/mail/cltbld', 09:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:09 INFO - 'MOZ_NO_REMOTE': '1', 09:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:09 INFO - 'NO_EM_RESTART': '1', 09:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:09 INFO - 'PWD': '/builds/slave/test', 09:11:09 INFO - 'SHELL': '/bin/bash', 09:11:09 INFO - 'SHLVL': '1', 09:11:09 INFO - 'TERM': 'linux', 09:11:09 INFO - 'TMOUT': '86400', 09:11:09 INFO - 'USER': 'cltbld', 09:11:09 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', 09:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:09 INFO - '_': '/tools/buildbot/bin/python'} 09:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:09 INFO - Downloading/unpacking blobuploader==1.2.4 09:11:09 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 09:11:09 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 09:11:09 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 09:11:09 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 09:11:09 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 09:11:09 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 09:11:11 INFO - Downloading blobuploader-1.2.4.tar.gz 09:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:11:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:11: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 09:11: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 09:11: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 09:11: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 09:11: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 09:11: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 09:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:11:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:11:12 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 09:11:12 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 09:11:12 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 09:11:12 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 09:11:12 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 09:11:12 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 09:11:12 INFO - Downloading docopt-0.6.1.tar.gz 09:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:11:12 INFO - Installing collected packages: blobuploader, requests, docopt 09:11:12 INFO - Running setup.py install for blobuploader 09:11:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:11:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:11:12 INFO - Running setup.py install for requests 09:11:13 INFO - Running setup.py install for docopt 09:11:13 INFO - Successfully installed blobuploader requests docopt 09:11:13 INFO - Cleaning up... 09:11:13 INFO - Return code: 0 09:11:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:13 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')]} 09:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:13 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')]} 09:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:13 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 0x7f87f1348e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1406b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1630fc0>, '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 0x1631ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1632350>, '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': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', '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 09:11:13 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 09:11:13 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 09:11:13 INFO - Using env: {'DISPLAY': ':0', 09:11:13 INFO - 'HOME': '/home/cltbld', 09:11:13 INFO - 'LANG': 'en_US.UTF-8', 09:11:13 INFO - 'LANGUAGE': 'en_US:en', 09:11:13 INFO - 'LOGNAME': 'cltbld', 09:11:13 INFO - 'MAIL': '/var/mail/cltbld', 09:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:13 INFO - 'MOZ_NO_REMOTE': '1', 09:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:13 INFO - 'NO_EM_RESTART': '1', 09:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:13 INFO - 'PWD': '/builds/slave/test', 09:11:13 INFO - 'SHELL': '/bin/bash', 09:11:13 INFO - 'SHLVL': '1', 09:11:13 INFO - 'TERM': 'linux', 09:11:13 INFO - 'TMOUT': '86400', 09:11:13 INFO - 'USER': 'cltbld', 09:11:13 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', 09:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:13 INFO - '_': '/tools/buildbot/bin/python'} 09:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:11:13 INFO - Running setup.py (path:/tmp/pip-O9oZus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:11:13 INFO - Running setup.py (path:/tmp/pip-Wwzy90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:11:13 INFO - Running setup.py (path:/tmp/pip-26dZY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:11:13 INFO - Running setup.py (path:/tmp/pip-vtuozT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:11:13 INFO - Running setup.py (path:/tmp/pip-Z70Dt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:11:13 INFO - Running setup.py (path:/tmp/pip-Sd0T4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:11:13 INFO - Running setup.py (path:/tmp/pip-Lpf9Nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:11:13 INFO - Running setup.py (path:/tmp/pip-U1mFkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:11:14 INFO - Running setup.py (path:/tmp/pip-EzjZzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:11:14 INFO - Running setup.py (path:/tmp/pip-38OEWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:11:14 INFO - Running setup.py (path:/tmp/pip-MWJXpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:11:14 INFO - Running setup.py (path:/tmp/pip-DoCjOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:11:14 INFO - Running setup.py (path:/tmp/pip-kAq0pR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:11:14 INFO - Running setup.py (path:/tmp/pip-cHCP3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:14 INFO - Running setup.py (path:/tmp/pip-meZvjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:11:14 INFO - Running setup.py (path:/tmp/pip-5FhA8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:11:14 INFO - Running setup.py (path:/tmp/pip-9A4wvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:11:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:11:14 INFO - Running setup.py install for manifestparser 09:11:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:11:14 INFO - Running setup.py install for mozcrash 09:11:14 INFO - Running setup.py install for mozdebug 09:11:15 INFO - Running setup.py install for mozdevice 09:11:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:11:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:11:15 INFO - Running setup.py install for mozfile 09:11:15 INFO - Running setup.py install for mozhttpd 09:11:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:11:15 INFO - Running setup.py install for mozinfo 09:11:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:11:15 INFO - Running setup.py install for mozInstall 09:11:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:11:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:11:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:11:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:11:15 INFO - Running setup.py install for mozleak 09:11:15 INFO - Running setup.py install for mozlog 09:11:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:11:15 INFO - Running setup.py install for moznetwork 09:11:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:11:15 INFO - Running setup.py install for mozprocess 09:11:15 INFO - Running setup.py install for mozprofile 09:11:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:11:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:11:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:11:16 INFO - Running setup.py install for mozrunner 09:11:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:11:16 INFO - Running setup.py install for mozscreenshot 09:11:16 INFO - Running setup.py install for moztest 09:11:16 INFO - Running setup.py install for mozversion 09:11:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:11:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:11:16 INFO - Cleaning up... 09:11:16 INFO - Return code: 0 09:11:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:16 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')]} 09:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:16 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')]} 09:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:16 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 0x7f87f1348e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1406b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1630fc0>, '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 0x1631ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1632350>, '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': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', '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 09:11:16 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 09:11:16 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 09:11:16 INFO - Using env: {'DISPLAY': ':0', 09:11:16 INFO - 'HOME': '/home/cltbld', 09:11:16 INFO - 'LANG': 'en_US.UTF-8', 09:11:16 INFO - 'LANGUAGE': 'en_US:en', 09:11:16 INFO - 'LOGNAME': 'cltbld', 09:11:16 INFO - 'MAIL': '/var/mail/cltbld', 09:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:16 INFO - 'MOZ_NO_REMOTE': '1', 09:11:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:16 INFO - 'NO_EM_RESTART': '1', 09:11:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:16 INFO - 'PWD': '/builds/slave/test', 09:11:16 INFO - 'SHELL': '/bin/bash', 09:11:16 INFO - 'SHLVL': '1', 09:11:16 INFO - 'TERM': 'linux', 09:11:16 INFO - 'TMOUT': '86400', 09:11:16 INFO - 'USER': 'cltbld', 09:11:16 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', 09:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:16 INFO - '_': '/tools/buildbot/bin/python'} 09:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:11:16 INFO - Running setup.py (path:/tmp/pip-3b8ELl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:11:16 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)) 09:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:11:16 INFO - Running setup.py (path:/tmp/pip-ftu57B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:11:16 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)) 09:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:11:16 INFO - Running setup.py (path:/tmp/pip-gC1CSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:11:16 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)) 09:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:11:16 INFO - Running setup.py (path:/tmp/pip-dHEdJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:11:17 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)) 09:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:11:17 INFO - Running setup.py (path:/tmp/pip-RudDyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:11:17 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)) 09:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:11:17 INFO - Running setup.py (path:/tmp/pip-ZaX0LA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:11:17 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)) 09:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:11:17 INFO - Running setup.py (path:/tmp/pip-CoUSlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:11:17 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)) 09:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:11:17 INFO - Running setup.py (path:/tmp/pip-vi1tLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:11:17 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)) 09:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:11:17 INFO - Running setup.py (path:/tmp/pip-CBq0sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:11:17 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)) 09:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:11:17 INFO - Running setup.py (path:/tmp/pip-oJrNR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:11:17 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)) 09:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:11:17 INFO - Running setup.py (path:/tmp/pip-sJcjWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:11:17 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)) 09:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:11:17 INFO - Running setup.py (path:/tmp/pip-hSUEgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:11:17 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)) 09:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:11:17 INFO - Running setup.py (path:/tmp/pip-euTJFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:11:17 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)) 09:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:11:17 INFO - Running setup.py (path:/tmp/pip-TDbcTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:11:17 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)) 09:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:17 INFO - Running setup.py (path:/tmp/pip-rWeYnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:17 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)) 09:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:11:17 INFO - Running setup.py (path:/tmp/pip-C6cWxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:11:17 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)) 09:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:11:17 INFO - Running setup.py (path:/tmp/pip-y24_a_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:11:18 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)) 09:11:18 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)) 09:11:18 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)) 09:11:18 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)) 09:11:18 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)) 09:11:18 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)) 09:11:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:11:18 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 09:11:18 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 09:11:18 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 09:11:18 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 09:11:18 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 09:11:18 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 09:11:19 INFO - Downloading blessings-1.6.tar.gz 09:11:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:11:20 INFO - Installing collected packages: blessings 09:11:20 INFO - Running setup.py install for blessings 09:11:20 INFO - Successfully installed blessings 09:11:20 INFO - Cleaning up... 09:11:20 INFO - Return code: 0 09:11:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:11:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:11:20 INFO - Reading from file tmpfile_stdout 09:11:20 INFO - Current package versions: 09:11:20 INFO - argparse == 1.2.1 09:11:20 INFO - blessings == 1.6 09:11:20 INFO - blobuploader == 1.2.4 09:11:20 INFO - docopt == 0.6.1 09:11:20 INFO - functools32 == 3.2.3-2 09:11:20 INFO - jsonschema == 2.5.1 09:11:20 INFO - manifestparser == 1.1 09:11:20 INFO - mozInstall == 1.12 09:11:20 INFO - mozcrash == 1.0 09:11:20 INFO - mozdebug == 0.1 09:11:20 INFO - mozdevice == 0.49 09:11:20 INFO - mozfile == 1.2 09:11:20 INFO - mozhttpd == 0.7 09:11:20 INFO - mozinfo == 0.9 09:11:20 INFO - mozleak == 0.1 09:11:20 INFO - mozlog == 3.4 09:11:20 INFO - moznetwork == 0.27 09:11:20 INFO - mozprocess == 0.23 09:11:20 INFO - mozprofile == 0.28 09:11:20 INFO - mozrunner == 6.13 09:11:20 INFO - mozscreenshot == 0.1 09:11:20 INFO - mozsystemmonitor == 0.3 09:11:20 INFO - moztest == 0.7 09:11:20 INFO - mozversion == 1.4 09:11:20 INFO - psutil == 3.1.1 09:11:20 INFO - requests == 1.2.3 09:11:20 INFO - wsgiref == 0.1.2 09:11:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:20 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')]} 09:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:20 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')]} 09:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:20 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 0x7f87f1348e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1406b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1630fc0>, '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 0x1631ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1632350>, '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': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', '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 09:11:20 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 09:11:20 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 09:11:20 INFO - Using env: {'DISPLAY': ':0', 09:11:20 INFO - 'HOME': '/home/cltbld', 09:11:20 INFO - 'LANG': 'en_US.UTF-8', 09:11:20 INFO - 'LANGUAGE': 'en_US:en', 09:11:20 INFO - 'LOGNAME': 'cltbld', 09:11:20 INFO - 'MAIL': '/var/mail/cltbld', 09:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:20 INFO - 'MOZ_NO_REMOTE': '1', 09:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:20 INFO - 'NO_EM_RESTART': '1', 09:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:20 INFO - 'PWD': '/builds/slave/test', 09:11:20 INFO - 'SHELL': '/bin/bash', 09:11:20 INFO - 'SHLVL': '1', 09:11:20 INFO - 'TERM': 'linux', 09:11:20 INFO - 'TMOUT': '86400', 09:11:20 INFO - 'USER': 'cltbld', 09:11:20 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', 09:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:20 INFO - '_': '/tools/buildbot/bin/python'} 09:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:20 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)) 09:11:20 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)) 09:11:20 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)) 09:11:20 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)) 09:11:20 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)) 09:11:20 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)) 09:11:20 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)) 09:11:20 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)) 09:11:20 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)) 09:11:20 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)) 09:11:20 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)) 09:11:20 INFO - Cleaning up... 09:11:20 INFO - Return code: 0 09:11:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:11:20 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')]} 09:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:20 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')]} 09:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:20 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 0x7f87f1348e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1406b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1630fc0>, '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 0x1631ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1632350>, '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': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', '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 09:11:20 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 09:11:20 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 09:11:20 INFO - Using env: {'DISPLAY': ':0', 09:11:20 INFO - 'HOME': '/home/cltbld', 09:11:20 INFO - 'LANG': 'en_US.UTF-8', 09:11:20 INFO - 'LANGUAGE': 'en_US:en', 09:11:20 INFO - 'LOGNAME': 'cltbld', 09:11:20 INFO - 'MAIL': '/var/mail/cltbld', 09:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:20 INFO - 'MOZ_NO_REMOTE': '1', 09:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:20 INFO - 'NO_EM_RESTART': '1', 09:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:20 INFO - 'PWD': '/builds/slave/test', 09:11:20 INFO - 'SHELL': '/bin/bash', 09:11:20 INFO - 'SHLVL': '1', 09:11:20 INFO - 'TERM': 'linux', 09:11:20 INFO - 'TMOUT': '86400', 09:11:20 INFO - 'USER': 'cltbld', 09:11:20 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', 09:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:20 INFO - '_': '/tools/buildbot/bin/python'} 09:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:11:20 INFO - Cleaning up... 09:11:20 INFO - Return code: 0 09:11:20 INFO - Running post-action listener: _resource_record_post_action 09:11:20 INFO - Running post-action listener: _start_resource_monitoring 09:11:20 INFO - Starting resource monitoring. 09:11:20 INFO - [mozharness: 2016-11-27 17:11:20.916452Z] Finished create-virtualenv step (success) 09:11:20 INFO - [mozharness: 2016-11-27 17:11:20.917041Z] Running install step. 09:11:20 INFO - Running pre-action listener: _resource_record_pre_action 09:11:20 INFO - Running main action method: install 09:11:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:11:21 INFO - Reading from file tmpfile_stdout 09:11:21 INFO - Detecting whether we're running mozinstall >=1.0... 09:11:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:11:21 INFO - Reading from file tmpfile_stdout 09:11:21 INFO - Output received: 09:11:21 INFO - Usage: mozinstall [options] installer 09:11:21 INFO - Options: 09:11:21 INFO - -h, --help show this help message and exit 09:11:21 INFO - -d DEST, --destination=DEST 09:11:21 INFO - Directory to install application into. [default: 09:11:21 INFO - "/builds/slave/test"] 09:11:21 INFO - --app=APP Application being installed. [default: firefox] 09:11:21 INFO - mkdir: /builds/slave/test/build/application 09:11:21 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'] 09:11:21 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 09:11:38 INFO - Reading from file tmpfile_stdout 09:11:38 INFO - Output received: 09:11:38 INFO - /builds/slave/test/build/application/firefox/firefox 09:11:38 INFO - Running post-action listener: _resource_record_post_action 09:11:38 INFO - [mozharness: 2016-11-27 17:11:38.211451Z] Finished install step (success) 09:11:38 INFO - [mozharness: 2016-11-27 17:11:38.211692Z] Running run-tests step. 09:11:38 INFO - Running pre-action listener: _resource_record_pre_action 09:11:38 INFO - Running main action method: run_tests 09:11:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:11:38 INFO - Python 2.7.3 09:11:38 INFO - Return code: 0 09:11:38 INFO - grabbing minidump binary from tooltool 09:11:38 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')]} 09:11:38 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 0x1630fc0>, '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 0x1631ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1632350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:11:38 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 09:11:38 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 09:11:38 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 09:11:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:11:38 INFO - Return code: 0 09:11:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:11:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:11:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:11:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:11:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:11:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 09:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 09:11:38 INFO - Using env: {'DISPLAY': ':0', 09:11:38 INFO - 'HOME': '/home/cltbld', 09:11:38 INFO - 'LANG': 'en_US.UTF-8', 09:11:38 INFO - 'LANGUAGE': 'en_US:en', 09:11:38 INFO - 'LOGNAME': 'cltbld', 09:11:38 INFO - 'MAIL': '/var/mail/cltbld', 09:11:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:11:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:38 INFO - 'MOZ_NO_REMOTE': '1', 09:11:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:38 INFO - 'NO_EM_RESTART': '1', 09:11:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:38 INFO - 'PWD': '/builds/slave/test', 09:11:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:11:38 INFO - 'SHELL': '/bin/bash', 09:11:38 INFO - 'SHLVL': '1', 09:11:38 INFO - 'TERM': 'linux', 09:11:38 INFO - 'TMOUT': '86400', 09:11:38 INFO - 'USER': 'cltbld', 09:11:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480255321.703855-417090065', 09:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:38 INFO - '_': '/tools/buildbot/bin/python'} 09:11:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 09:11:38 INFO - mozversion application_buildid: 20161127063011 09:11:38 INFO - mozversion application_changeset: c17948ef9b358c38d267032dc7667142e8c08909 09:11:38 INFO - mozversion application_display_name: Nightly 09:11:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:11:38 INFO - mozversion application_name: Firefox 09:11:38 INFO - mozversion application_remotingname: firefox 09:11:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:11:38 INFO - mozversion application_vendor: Mozilla 09:11:38 INFO - mozversion application_version: 53.0a1 09:11:38 INFO - mozversion platform_buildid: 20161127063011 09:11:38 INFO - mozversion platform_changeset: c17948ef9b358c38d267032dc7667142e8c08909 09:11:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:11:38 INFO - mozversion platform_version: 53.0a1 09:11:38 INFO - using testdate: 1480266698 09:11:38 INFO - actual date: 1480266698 09:11:38 INFO - starting webserver on 'localhost:40846' 09:11:38 INFO - SUITE-START | Running 2 tests 09:11:38 INFO - TEST-START | dromaeo_css 09:11:38 INFO - operating with platform_type : linux_ 09:11:38 INFO - Initialising browser for dromaeo_css test... 09:11:38 INFO - TEST-INFO | started process 30039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAxwDMi/profile http://localhost:40846/getInfo.html) 09:11:43 INFO - PROCESS | 30039 | __metrics Screen width/height:1600/1200 09:11:43 INFO - PROCESS | 30039 | colorDepth:24 09:11:43 INFO - PROCESS | 30039 | Browser inner width/height: 1024/697 09:11:43 INFO - PROCESS | 30039 | __metrics 09:11:43 ERROR - PROCESS | 30039 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 09:11:44 INFO - TEST-INFO | 30039: exit 0 09:11:44 INFO - Browser initialized. 09:11:44 INFO - Running cycle 1/1 for dromaeo_css test... 09:11:44 INFO - TEST-INFO | started process 30163 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAxwDMi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:11:56 INFO - PROCESS | 30163 | RSS: Main: 186355712 09:11:56 INFO - PROCESS | 30163 | 09:12:46 INFO - PROCESS | 30163 | 1480266766571 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] 09:14:57 INFO - PROCESS | 30163 | Cycle 1(1): loaded http://localhost:40846/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40846/tests/dromaeo/cssquery-ext.html) 09:14:59 INFO - PROCESS | 30163 | RSS: Main: 198737920 09:14:59 INFO - PROCESS | 30163 | 09:18:02 INFO - PROCESS | 30163 | Cycle 1(1): loaded http://localhost:40846/tests/dromaeo/cssquery-ext.html (next: http://localhost:40846/tests/dromaeo/cssquery-jquery.html) 09:18:02 INFO - PROCESS | 30163 | RSS: Main: 197337088 09:18:02 INFO - PROCESS | 30163 | 09:21:04 INFO - PROCESS | 30163 | Cycle 1(1): loaded http://localhost:40846/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40846/tests/dromaeo/cssquery-mootools.html) 09:21:05 INFO - PROCESS | 30163 | RSS: Main: 199970816 09:21:05 INFO - PROCESS | 30163 | 09:24:07 INFO - PROCESS | 30163 | Cycle 1(1): loaded http://localhost:40846/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40846/tests/dromaeo/cssquery-prototype.html) 09:24:07 INFO - PROCESS | 30163 | RSS: Main: 196091904 09:24:07 INFO - PROCESS | 30163 | 09:27:10 INFO - PROCESS | 30163 | Cycle 1(1): loaded http://localhost:40846/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40846/tests/dromaeo/cssquery-yui.html) 09:27:11 INFO - PROCESS | 30163 | RSS: Main: 200163328 09:27:11 INFO - PROCESS | 30163 | 09:30:14 INFO - PROCESS | 30163 | Cycle 1(1): loaded http://localhost:40846/tests/dromaeo/cssquery-yui.html (next: http://localhost:40846/tests/dromaeo/cssquery-dojo.html) 09:30:14 INFO - PROCESS | 30163 | RSS: Main: 200036352 09:30:14 INFO - PROCESS | 30163 | 09:30:14 INFO - PROCESS | 30163 | __start_tp_report 09:30:14 INFO - PROCESS | 30163 | _x_x_mozilla_page_load 09:30:14 INFO - PROCESS | 30163 | _x_x_mozilla_page_load_details 09:30:14 INFO - PROCESS | 30163 | |i|pagename|runs| 09:30:14 INFO - PROCESS | 30163 | |0;dojo.html;3076.092552696954;3076.5538996845453;3087.1356020314306;3111.2688518198206;3112.6109236345455;5269.86825329367;5336.146216605339;5364.195370694393;5421.810236641718;5436.048691478995;5403.675779453236;5469.371022332433;5523.199136125259;5530.834074977757;5579.442055794419;4886.828960986366;4973.850784476463;5007.7496125193775;5008.373953255843;5011.674241174312;4597.539411165984;5043.949560504403;5118.129917913963;5123.743812809364;5158.845234642967;5064.696118232881;5116.079105760961;5116.283720279164;5117.795288188468;5130.38435387754;4856.538628830255;4874.098291816025;4887.804487820483;4945.901081978376;4946.530079642428;4887.780049897763;4896.706197628154;4899;4903.632227582945;4906.533879281463;5301.204819277139;5341.1988201769655;5378.731063446812;5390.164524498709;5390.595705322077;5758.539316854642;5763.221965034751;5781.884362312772;5798.565107616903;5827.883442331172;5793.710314484301;5818.44724751148;5828.737706803204;5896.056630939072;5909.527237820964;5370.409254981949;5395.271638328775;5434.130539113723;5483.396826349099;5508.641938274;5842.941570584239;5884.117382392676;5906.852328691731;5913.02435098204;5940.168376427304;5615.185798059259;5671.51792097668;5692.23154874095;5701.287339082614;5746.9712651436475;5682.318121825408;5732.971335143297;5736.340320863154;5767.538596912321;5792.507636850831;5631.070873305941;5757.481826635623;5765.971170144123;5767.826965191051;5810.244668193192;5716;5741.712914354265;5752.654840709571;5807.274090738658;5882;4386.407834942242;4433.534478879736;4434.068845542472;4449.421575195204;4496.145732310851;3951.9604803951593;3969.4641223435046;3978.8010599469912;4029.5970402960056;4033.4353190553347;5353.411124776271;5380.838574842761;5401.378841433286;5406;5406.8918621627345;5728.455796699307;5730.111832665943;5781.508571771363;5807;5847.56143289255;5343.305370301913;5396.595255355864;5478.534324582455;5480.232767412565;5483.8080667177255;4839.806407743651;4967.5777558907175;4989.55094041538;5012.874678133003;5060.949390506122;5913.172155898264;6003.459688628044;6016.849578760391;6056.909146362808;6073.028315469592;5874.324452687995;5915.319738230159;5923.4076592340425;5923.733431995484;5977.790777322947;5910.113482977587;6029.909551356645;6046.7278972445465;6047.667378294236;6062.36345183767;5494.532964698045;5523.585731070106;5569.777208911761;5754.741036653444;5770.480656740913;5720.599558030898;5720.971395143164;5726.198332233407;5741.3397459291045;5748.54011679073;5550.361708403585;5576.721163941867;5584.078627026495;5608.747606357642;5675.148727690715;5632.464915832989;5653.971730141488;5663.490285874126;5678.119891416837;5692.089265717465;5513.393526712139;5615.410381910004;5642.689652069175;5655.886882262414;5672.829815105553;5639.7180140993605;5644.6330988485615;5667.093265077568;5677.51741102011;5721.485066344049;5584.776608935597;5592.86017849557;5598.944010560005;5602.775888964396;5656.434356564475 09:30:14 INFO - PROCESS | 30163 | |1;ext.html;548.5693730421618;563.385909358799;572.8367415286644;572.9283839520061;585.6837307853757;39544.40683389751;41192.17615647689;41420.17159656805;44193.55806441935;44492;42192;42764.572354276446;42869.57130428695;42892;42908.570914290845;8451.239388455038;8575.871361929576;8581.742547723547;8583.914160858374;10112.089911907964;9986.751656042994;10330.690079297596;10340.482975851215;10345.741356466111;10349.223808214376;10357.533910974023;10359.741006474824;10398.740031499236;10407.739806504822;10408;10198;10330.793384132312;10384;10411.635592754294;10413.281808501588;10077.244206684529;10154;10160.390376577428;10165.135963443116;10211.234157438223;39542.60457395418;39763.60236397628;40044.59955400438;40147.39778903319;40210.39684404707;3445.12073835381;3489.023073539413;3495.73781966351;3617.8914632561064;3787.3561494545993;29244.70755292441;30476.085717428512;30561.694383056107;30621.846890765628;30834.53748193779;4056.7971601419813;4104.733192342518;4192.5807419258135;4387.276099443588;4398.582134697199;318919;320064;320525;320852;321923;57468.71265643645;57718.422815772145;57857.421425786044;57943;57997;58650.70674646599;59278.62885484619;59616;59676.70161649164;60121;14764.557063287904;14919.179445130621;15035;15073.321700523502;15119.470818521519;11773.88226117745;11835.11236657254;11835.763284734257;11839.763204735857;11888.28670279786;18475.35336263251;18856.905715471334;19809.603807923762;19823.900880495792;19847.503812404517;7301.333599720272;7482.139553951365;7796.337311328487;7808.726694565663;7811.68753249875;909.2544113826731;989.5744829723288;990.4453506036642;1037.258360272409;1053.3258714422775;31470.213244669067;31639.683603164132;31781.205469862976;31819.20451988719;32024.199395014846;1048.496721573649;1093.1364222264322;1093.147345070846;1101.2071308657753;1190.595197632809;15608.453704120302;16507.58731031734;16520.42178523746;16606.584835379213;16822.158892055348;486029;499032;501723;762443;777123;54482;55148;55381.44618553763;55665.44334556683;55778.442215578136;1323.6492329532682;1335.9198448093146;1373.3811406942577;1380.4547203854422;1381.461230120274;29404.354867734117;30982;31497.527537086502;31856.522152167272;31961.840190798895;49070.509294906595;49130.75434622804;49831.252531211336;49831.750841245565;49844.750776245884;455401;456656;456929;458167;461511;27249.727502725513;27867.860660696566;27994.16017519478;28070.71929280763;29680.55479167771;44742;45275.54724452713;46108.53891461177;46143;46478.53521464742;38691.613083868804;39202.2159556813;39417.40873886951;40349;41040.79479602583;38396.42405363866;38648.2270354597;38873.2225355497;39420.211595768495;39764.40353394643;38117;39411.60588394194;39515.2096958065;39876.60123398729;39891.00272493211;33556.328873422884;35624.821875890455;35713.64286357103;36183.29617149754;36325.27349453049;26868.73131268662;26888.32779180536;27016.59475107914;27307.86346068257;27401.31496712598 09:30:14 INFO - PROCESS | 30163 | |2;jquery.html;394.09948268207114;394.4044492815849;405.0824881643078;408.06756561257515;422.9890561557877;17860.196291166896;18576.071196440174;18629.627407451844;18671.346502872402;19800.60398792027;18208.45374638763;18286.17712202951;18567.07164641769;18764;18806.24775008998;5601.551875849943;5636.915446268309;5730.484256416921;5768.826935191951;5802.361740208574;5615.410381909902;5648.943510564883;5656.151577263402;5659.151127330892;5688.516476099537;5459.754311056012;5588.413216612258;5648.661080335193;5655.943440565583;5675.602707810455;5558;5563.749631266583;5609.52319052881;5624.578156638248;5632.957902787997;4887.633427492952;5027.296178535008;5065.518775716338;5069.923951140736;5092.770825312869;22654.66018009731;22665.66001509962;22843.42891427711;22983.770162298497;23312.184073557342;2192.5943700415473;2297.333773205785;2515.8490490570443;2682.329417645589;2838.446502931929;9949.955254698298;10839.783204335949;11549.422528873607;14054;14891.404343826342;1769.7256925176619;1802.22504323141;1883.962320753591;1898.32609423654;1919.1651631540324;78589.21410785876;79941.60029199875;80084.3877637745;80632.19367806305;81828.18171818324;10409.115225205791;11118.221724479208;11269.605563805228;11315;11362.715932101599;14091.647708807363;14106.929465352607;14141.71716565663;14166;14287.64280892986;7260.535743085711;7806.57063861493;7869.48848324857;7906.248906353887;8070.596470176468;7483.251674832473;7521.210272921265;7701.807454813675;7744.612769361509;7771.067471903295;4289.914201715948;4407.581279778416;4509;4545.840895568639;4612.723236605814;1897.724829899657;1969.409177246849;1986.2849374225268;1991.4523506035955;2041.2141325589755;888.9377743558018;917.6833992272656;921.5162039928957;975.7414285214423;1040.287403128859;18187.272509099486;19259;19515;19705.704414433796;19788.802111978697;948.7201275623707;953.580424613168;981.5337714585658;1004.2417974429405;1005.9638572270572;10194.184465242763;10871.891281087088;10913.727156820984;10987.725306867393;11019.614313498989;373529;373721;375133;376665;382061;67100;84602;85460;90221.54889225512;95382;974.5224839828433;1003.6888564545014;1052.6947185316174;1055.7835643693024;1055.7941201465794;16101.597460063593;17278.568035799206;17640.55898602494;17658;17666.381676641256;39560.40659390169;40110.79944600258;40504;41025;41384.37923431211;53871;54736.726316368164;54785.45214547963;55911.720441397534;56155.43844561502;7488.251174882686;7811.726589569338;7909.288164065261;7949.76778599318;8293.419460637697;11068.059214966495;12001.219920705125;12139.514419423123;12145.81781273264;12510.937445312715;10935.28920620189;11052.171087168334;11390.145739069769;11692.824607630722;11827.290362578273;5228.163493840967;8136.75589732309;10627.140250456294;10756.978087081714;11239.943800280946;11031.558737650405;11125.109991200847;11172.385518796544;11264.38045907483;11704.297742135499;7938.285554300141;7973.362131029619;8235.423520353757;8280.420370574002;8337.791555211168;9719.368241064309;10642.89357106419;11055.502502387573;11181;11564.94217528907 09:30:14 INFO - PROCESS | 30163 | |3;mootools.html;1450.934707938143;1456.1481533303017;1595.9281832317545;1706.650136721972;1738.4436980166336;7562.659680314386;7617.80955476112;7752.263534964177;7760.767176984686;7899.960500197498;7985.520868747879;8266.875996860052;8277.048139463963;8372.246497815195;8511.829763404729;2173.565286942614;2208.4920468292303;2222.3333000099988;2222.3666255117296;2229.2866282789514;2272.0570963050313;2283.1438210671;2283.577538155438;2314.5833749925005;2324.267855625481;2155.5257843274453;2188.387251569563;2200.460887082659;2206.735191776989;2227.3318004598555;2147.087487817687;2148.602508535926;2152.440365504964;2153.6231159547096;2161.470439742265;2176.4667656424117;2201.889905504718;2202.174184680745;2223.1996481266733;2229.3534874886427;8364.623591938378;8468.78828029298;8529.10444403335;8556.74329770108;8571.828563428759;4977.352944117278;5067.467915868818;5096.566791822699;5114.2840002399325;5134.589232861399;3126.5310203469435;3170.619525656913;3328.367610154063;3336.115929278743;3356.2784001439563;1084.1760262200785;1089.477051015509;1107.3909349857547;1120.456578559398;1138.1293310617384;11669.766604667944;11702.356370399624;11828.526858925632;11829.112816538707;11874.821877671842;4334.804933777988;4350.543192964757;4531.954680453219;4535.727856328631;4560.338750881104;9876.506174691236;9901.405915645084;9903.702888913343;9904.306698531178;9923.751906202258;5100.158473851773;5124.128898087334;5149.48505149482;5151.124308867502;5160.380754309507;4445.844080539083;4602.654800889946;4653.86038418848;4743.335932969387;4755.881102972384;3535.911602209965;3572.1248294168095;3604.675579197885;3686.612905644922;3692.335379631692;1111.1666250312267;1115.2694984784978;1127.3461392392392;1130.2596799096605;1133.0595605647293;882.302980645283;891.7324802559207;960.7309953213112;974.0940924939874;987.4223579206101;5536.640118392372;5710.371859095496;5756.395578464201;6082.635041897501;6123.326434092246;424.280843969475;432.2543612268874;435.61012893460173;436.21263619167706;437.2370213976631;3799.2781371539318;3864.4589757433982;3871.9806400967814;3894;3894.6105389460827;10019.198464122852;10420.478976051167;10524.36853788775;10548.894511054945;10551.419671918118;10196.643117490852;10338.53476593555;10489.318194317346;10575.36547807134;10608.681739547827;7526.134494533198;7867.331276841533;7931.246531579491;8038.758837234892;8055.677772889018;5885.087811389241;5898.734556944862;5902.970485147547;6046.969765151146;6065.484433822998;9361.765955851159;9451.196648284698;9585;9598.088181622734;9642.903570964201;9283.582238799405;9560.808783824423;9561.948185699706;9687.903120968982;9733.172680321968;7229.277072292729;7284.307990740871;7416.851662966818;7486.326230639269;7581.54510729358;8170.673173073011;8180.46826956246;8192.918070819454;8204;8260.628271727666;7075.646217689198;7218;7334.376577990931;7381.704731810667;7427.962860185665;7148.106486689164;7171.892421613576;7212.134543854771;7309.378702810321;7529.8117547061765;6668.166479190101;6711.261761206166;6719.596824190564;6787.151606049244;6805.183377994672;4994.275830004702;5041.369828771403;5113.769880355468;5250.133727935001;5256.474352564713;5101.311322971352;5152.124138896322;5211.348581427322;5226.843194704165;5316.521513063843 09:30:14 INFO - PROCESS | 30163 | |4;prototype.html;310.6567243196268;316.5742076906561;316.6722442272249;320.44882801581304;326.07557574276916;5369.194620806881;5416.539594134493;5423.376311724148;5423.91864122038;5435.374931882835;5170.9482905170935;5339.599530035253;5342.946570534294;5347.262139804559;5382.515573598375;4029.4560234368423;4088.8977775555627;4173.269677806387;4182.91634167318;4200.201961627296;4163.084121493267;4179.456670632813;4187.1416359646355;4192.517860446042;4193.259797184165;4123.969007748063;4148.958510414903;4155.376693495985;4182.996080940583;4183.728057676241;4076;4104.651104656108;4105.91788164235;4117.547069822317;4135.58644135587;3562.5012498250267;3564.3940530109944;3591.479235510836;3594.856205751767;3595.7303202259936;5216.7913283468615;5218.66078704883;5222;5223.71269580173;5225.242339860699;4583.656225783079;4692.671512994092;4697.436307643105;4736.6447516436065;4759.976200119012;5503.669779813224;5519.834404967817;5568.805091821767;5585.441455854423;5587.720613969326;4023.195360927797;4051.189762047573;4053.716239863211;4070.2470043041835;4073.6130067643526;5560.555155587584;5769.278840144982;5776.653400795965;5786.222613145714;5790.247267855194;4125.773082480492;4134.855280065243;4135.875923722293;4137.710360274812;4141.585841415835;4100.753954762724;4182.393552934868;4195.8741237762915;4203.108601129504;4217.240896638573;4588.311753236974;4789.114013907439;4796.160671882407;4834.444038935497;4852.126617208936;5552.91670624941;5578.581606379537;5589.888202235932;5611.887762244733;5635.605507614428;1397.6296281485415;1405.845357010728;1416.5055866061198;1436.3823555870867;1443.4082026369138;933.178802653674;933.487749845255;951.5004622573205;989.9010098990043;999.8500224966314;5350.197470379397;5515.172724091419;5522.972385138049;5530.944690553123;5555.666660000413;5823.4467725566;5829.329627092854;5867.442592953663;5874.179004508616;5878.882422351529;5194.792208311701;5431.321084864392;5496.835094947158;5497.4607110009265;5549.334079910436;2924.6164376033466;2947.6462824460773;2976.9702302976693;2977.702229777048;2983.686712895115;5700.344460387026;5703.828885133453;5792.507636850914;5866.560007999417;5895.35151133375;5696.743646535916;5711.8857622848145;5726.455986681259;5741.5119714824705;5764.971175144181;5853.765849366063;5876.206712093898;5877.441643043904;5894.793682221101;5905.464579209351;5415.566754659697;5644;5673;5677.445149682577;5717.914231286451;5553.389127195925;5579.358373787067;5606.24315717373;5618.803341883015;5623.859403514781;5718.513926316144;5778.526475748826;5888.205092312654;5890.52875769946;6004.969975150097;3917.9020524485977;3920.137569734654;3928.3893603622378;3953.4069889515654;3954.2289253596423;5656.575756818337;5662.490375866192;5698.857528561653;5708.80019199326;5723.370429252695;5326.242340027859;5481.287432633732;5519.724013799214;5535.671438854565;5549.861253468695;5434.619576629598;5440.727963601725;5466.972665136649;5470.671759694431;5477.3427188737605;5360.356757189163;5374.570034397317;5374.838754837361;5400.2439658447065;5448.673079615236;5557.943990641765;5561.610687251854;5659.801906933238;5694.829155125353;5711.087904785069;5556.499915007668;5559.416261292506;5571.13647384656;5586.413426590312;5594.1608758686525 09:30:14 INFO - PROCESS | 30163 | |5;yui.html;707.766437075765;734.5555938657112;739.0650826704224;767.8042099264691;804.7666176808726;14456.421743130275;16425.83574164258;16681.165941702926;16856.49430517085;17628.20673069712;16773.664526709457;16829.66340673186;16847.915760421212;16925.238364273606;16937.407190748327;773.5126870071861;808.8867558541809;813.8209593889335;816.9714060007901;817.264461984213;785.1520358013361;819.3281509162489;819.647551552832;823.8022874510134;823.9382046346518;849.0914721248236;852.1478521478522;852.3181454836138;855.4012191465968;856.7087190355278;846.8179341441589;849.0660273698943;849.2569002123142;850.2475309351207;850.6342272822684;619.9628022318631;620.5501011766478;621.0839012456636;622.1973653986353;624.1168746224088;14729.337179826933;14941.103533788008;15409.152496612682;15481.458148964732;15593.610159745984;13656;13922.234277114754;14264.85735142656;14338.713225735532;14518;11350.659480215525;11460.94269528647;11479.827802582968;11769.529218831321;11796.115291353182;3523.6828685418436;3574.6246644102257;3606.6934310583633;3636.9272614547826;3653.12325041988;73481.63259183723;73819.26180738177;74251.62874185649;76056.61971690106;76921.23078769197;10900.836487452694;11016.944915275533;11412.543498260142;11502.654920352235;11547.249428787101;20968;21304.893475532524;21313.360599182048;21432;21452.463688407603;7638.274363935418;7819.569923654253;7890.723824666109;7970.84058318842;8041.718539851077;4561.475430325489;4570.9314360284625;4621.353010578522;4743.217369134123;4845.176320025534;3595.2449985502813;3664.5602527696847;3677.7977211253638;3694.833732482045;3735.9066023349633;593.4807043836643;594.2215697436372;611.1321922869536;623.2489849731063;645.3449748505271;649.217692680319;655.2562841175301;728.191707205002;755.6335177438938;755.8261599831959;9523.19052880513;9956.551955162035;10019.148372388283;10115.241356898116;10125.797484050425;614.3303798859265;677.5832862789349;717.6375930155239;727.9235680253603;734.8236423258379;4362.432883725095;4659.697119687209;4706.223473126965;4724.503927087675;4748.240281555004;81229;82477.58761206275;83969.58015209885;84028.57985710155;86443.13556864476;68051;69768.6511567449;71794;73165.6341718288;75825.62087189528;62964;64507.67746161333;66549.00529476185;66732.33267667261;66938.66530667315;9036.728898133066;9101.954490227772;9207.907920920972;9230.169284764403;9234.722958311262;46002.30996534988;46421.30368044414;47269.2909606363;47270.76364618155;47912.04175916532;45362.77318613518;51351.48648513616;59062.704686476296;59166;61929.071063933174;11714.23857449263;11791.35147566892;11987.880121198676;12130.939345303217;12968.870311297143;13294.904151048497;13487.932560337136;13591.116577422436;13783;14115.647108822362;12586.496540138292;12880.420381082686;13018.414171362501;13219.272939988394;13450.26023568674;12467.438965246767;13067.34663266814;13127.540536081191;13197.868021319664;13497.539871894938;12358.382080896099;12564.87435125637;12978.221306721627;13007.219566826021;13149;10466.975931021441;10546.36721796664;10561.419121948367;10603.8939610606;10726.302790318605;10341.276110672181;10600.204984626029;10861.185411094042;11087.33475991443;11301.830472542753 09:30:14 INFO - PROCESS | 30163 | __end_tp_report 09:30:14 INFO - PROCESS | 30163 | __start_cc_report 09:30:14 INFO - PROCESS | 30163 | _x_x_mozilla_cycle_collect,337 09:30:14 INFO - PROCESS | 30163 | __end_cc_report 09:30:14 INFO - PROCESS | 30163 | __startTimestamp1480267814468__endTimestamp 09:30:14 INFO - PROCESS | 30163 | 09:30:14 INFO - PROCESS | 30163 | ------- Summary: start ------- 09:30:14 INFO - PROCESS | 30163 | Number of tests: 6 09:30:14 INFO - PROCESS | 30163 | 09:30:14 INFO - PROCESS | 30163 | [#0] dojo.html Cycles:165 Average:5382.51 Median:5584.78 stddev:607.72 (10.9%) stddev-sans-first:582.03 09:30:14 INFO - PROCESS | 30163 | Values: 3076.1 3076.6 3087.1 3111.3 3112.6 5269.9 5336.1 5364.2 5421.8 5436.0 5403.7 5469.4 5523.2 5530.8 5579.4 4886.8 4973.9 5007.7 5008.4 5011.7 4597.5 5043.9 5118.1 5123.7 5158.8 5064.7 5116.1 5116.3 5117.8 5130.4 4856.5 4874.1 4887.8 4945.9 4946.5 4887.8 4896.7 4899.0 4903.6 4906.5 5301.2 5341.2 5378.7 5390.2 5390.6 5758.5 5763.2 5781.9 5798.6 5827.9 5793.7 5818.4 5828.7 5896.1 5909.5 5370.4 5395.3 5434.1 5483.4 5508.6 5842.9 5884.1 5906.9 5913.0 5940.2 5615.2 5671.5 5692.2 5701.3 5747.0 5682.3 5733.0 5736.3 5767.5 5792.5 5631.1 5757.5 5766.0 5767.8 5810.2 5716.0 5741.7 5752.7 5807.3 5882.0 4386.4 4433.5 4434.1 4449.4 4496.1 3952.0 3969.5 3978.8 4029.6 4033.4 5353.4 5380.8 5401.4 5406.0 5406.9 5728.5 5730.1 5781.5 5807.0 5847.6 5343.3 5396.6 5478.5 5480.2 5483.8 4839.8 4967.6 4989.6 5012.9 5060.9 5913.2 6003.5 6016.8 6056.9 6073.0 5874.3 5915.3 5923.4 5923.7 5977.8 5910.1 6029.9 6046.7 6047.7 6062.4 5494.5 5523.6 5569.8 5754.7 5770.5 5720.6 5721.0 5726.2 5741.3 5748.5 5550.4 5576.7 5584.1 5608.7 5675.1 5632.5 5654.0 5663.5 5678.1 5692.1 5513.4 5615.4 5642.7 5655.9 5672.8 5639.7 5644.6 5667.1 5677.5 5721.5 5584.8 5592.9 5598.9 5602.8 5656.4 09:30:14 INFO - PROCESS | 30163 | 09:30:14 INFO - PROCESS | 30163 | [#1] ext.html Cycles:180 Average:61397.96 Median:20056.31 stddev:128656.95 (641.5%) stddev-sans-first:128936.75 09:30:14 INFO - PROCESS | 30163 | Values: 548.6 563.4 572.8 572.9 585.7 39544.4 41192.2 41420.2 44193.6 44492.0 42192.0 42764.6 42869.6 42892.0 42908.6 8451.2 8575.9 8581.7 8583.9 10112.1 9986.8 10330.7 10340.5 10345.7 10349.2 10357.5 10359.7 10398.7 10407.7 10408.0 10198.0 10330.8 10384.0 10411.6 10413.3 10077.2 10154.0 10160.4 10165.1 10211.2 39542.6 39763.6 40044.6 40147.4 40210.4 3445.1 3489.0 3495.7 3617.9 3787.4 29244.7 30476.1 30561.7 30621.8 30834.5 4056.8 4104.7 4192.6 4387.3 4398.6 318919.0 320064.0 320525.0 320852.0 321923.0 57468.7 57718.4 57857.4 57943.0 57997.0 58650.7 59278.6 59616.0 59676.7 60121.0 14764.6 14919.2 15035.0 15073.3 15119.5 11773.9 11835.1 11835.8 11839.8 11888.3 18475.4 18856.9 19809.6 19823.9 19847.5 7301.3 7482.1 7796.3 7808.7 7811.7 909.3 989.6 990.4 1037.3 1053.3 31470.2 31639.7 31781.2 31819.2 32024.2 1048.5 1093.1 1093.1 1101.2 1190.6 15608.5 16507.6 16520.4 16606.6 16822.2 486029.0 499032.0 501723.0 762443.0 777123.0 54482.0 55148.0 55381.4 55665.4 55778.4 1323.6 1335.9 1373.4 1380.5 1381.5 29404.4 30982.0 31497.5 31856.5 31961.8 49070.5 49130.8 49831.3 49831.8 49844.8 455401.0 456656.0 456929.0 458167.0 461511.0 27249.7 27867.9 27994.2 28070.7 29680.6 44742.0 45275.5 46108.5 46143.0 46478.5 38691.6 39202.2 39417.4 40349.0 41040.8 38396.4 38648.2 38873.2 39420.2 39764.4 38117.0 39411.6 39515.2 39876.6 39891.0 33556.3 35624.8 35713.6 36183.3 36325.3 26868.7 26888.3 27016.6 27307.9 27401.3 09:30:14 INFO - PROCESS | 30163 | 09:30:14 INFO - PROCESS | 30163 | [#2] jquery.html Cycles:180 Average:25263.10 Median:375899.00 stddev:62637.12 (16.7%) stddev-sans-first:62785.00 09:30:14 INFO - PROCESS | 30163 | Values: 394.1 394.4 405.1 408.1 423.0 17860.2 18576.1 18629.6 18671.3 19800.6 18208.5 18286.2 18567.1 18764.0 18806.2 5601.6 5636.9 5730.5 5768.8 5802.4 5615.4 5648.9 5656.2 5659.2 5688.5 5459.8 5588.4 5648.7 5655.9 5675.6 5558.0 5563.7 5609.5 5624.6 5633.0 4887.6 5027.3 5065.5 5069.9 5092.8 22654.7 22665.7 22843.4 22983.8 23312.2 2192.6 2297.3 2515.8 2682.3 2838.4 9950.0 10839.8 11549.4 14054.0 14891.4 1769.7 1802.2 1884.0 1898.3 1919.2 78589.2 79941.6 80084.4 80632.2 81828.2 10409.1 11118.2 11269.6 11315.0 11362.7 14091.6 14106.9 14141.7 14166.0 14287.6 7260.5 7806.6 7869.5 7906.2 8070.6 7483.3 7521.2 7701.8 7744.6 7771.1 4289.9 4407.6 4509.0 4545.8 4612.7 1897.7 1969.4 1986.3 1991.5 2041.2 888.9 917.7 921.5 975.7 1040.3 18187.3 19259.0 19515.0 19705.7 19788.8 948.7 953.6 981.5 1004.2 1006.0 10194.2 10871.9 10913.7 10987.7 11019.6 373529.0 373721.0 375133.0 376665.0 382061.0 67100.0 84602.0 85460.0 90221.5 95382.0 974.5 1003.7 1052.7 1055.8 1055.8 16101.6 17278.6 17640.6 17658.0 17666.4 39560.4 40110.8 40504.0 41025.0 41384.4 53871.0 54736.7 54785.5 55911.7 56155.4 7488.3 7811.7 7909.3 7949.8 8293.4 11068.1 12001.2 12139.5 12145.8 12510.9 10935.3 11052.2 11390.1 11692.8 11827.3 5228.2 8136.8 10627.1 10757.0 11239.9 11031.6 11125.1 11172.4 11264.4 11704.3 7938.3 7973.4 8235.4 8280.4 8337.8 9719.4 10642.9 11055.5 11181.0 11564.9 09:30:14 INFO - PROCESS | 30163 | 09:30:14 INFO - PROCESS | 30163 | [#3] mootools.html Cycles:180 Average:5538.06 Median:5100.73 stddev:3147.87 (61.7%) stddev-sans-first:3141.72 09:30:14 INFO - PROCESS | 30163 | Values: 1450.9 1456.1 1595.9 1706.7 1738.4 7562.7 7617.8 7752.3 7760.8 7900.0 7985.5 8266.9 8277.0 8372.2 8511.8 2173.6 2208.5 2222.3 2222.4 2229.3 2272.1 2283.1 2283.6 2314.6 2324.3 2155.5 2188.4 2200.5 2206.7 2227.3 2147.1 2148.6 2152.4 2153.6 2161.5 2176.5 2201.9 2202.2 2223.2 2229.4 8364.6 8468.8 8529.1 8556.7 8571.8 4977.4 5067.5 5096.6 5114.3 5134.6 3126.5 3170.6 3328.4 3336.1 3356.3 1084.2 1089.5 1107.4 1120.5 1138.1 11669.8 11702.4 11828.5 11829.1 11874.8 4334.8 4350.5 4532.0 4535.7 4560.3 9876.5 9901.4 9903.7 9904.3 9923.8 5100.2 5124.1 5149.5 5151.1 5160.4 4445.8 4602.7 4653.9 4743.3 4755.9 3535.9 3572.1 3604.7 3686.6 3692.3 1111.2 1115.3 1127.3 1130.3 1133.1 882.3 891.7 960.7 974.1 987.4 5536.6 5710.4 5756.4 6082.6 6123.3 424.3 432.3 435.6 436.2 437.2 3799.3 3864.5 3872.0 3894.0 3894.6 10019.2 10420.5 10524.4 10548.9 10551.4 10196.6 10338.5 10489.3 10575.4 10608.7 7526.1 7867.3 7931.2 8038.8 8055.7 5885.1 5898.7 5903.0 6047.0 6065.5 9361.8 9451.2 9585.0 9598.1 9642.9 9283.6 9560.8 9561.9 9687.9 9733.2 7229.3 7284.3 7416.9 7486.3 7581.5 8170.7 8180.5 8192.9 8204.0 8260.6 7075.6 7218.0 7334.4 7381.7 7428.0 7148.1 7171.9 7212.1 7309.4 7529.8 6668.2 6711.3 6719.6 6787.2 6805.2 4994.3 5041.4 5113.8 5250.1 5256.5 5101.3 5152.1 5211.3 5226.8 5316.5 09:30:14 INFO - PROCESS | 30163 | 09:30:14 INFO - PROCESS | 30163 | [#4] prototype.html Cycles:180 Average:4692.50 Median:5423.65 stddev:1381.53 (25.5%) stddev-sans-first:1345.69 09:30:14 INFO - PROCESS | 30163 | Values: 310.7 316.6 316.7 320.4 326.1 5369.2 5416.5 5423.4 5423.9 5435.4 5170.9 5339.6 5342.9 5347.3 5382.5 4029.5 4088.9 4173.3 4182.9 4200.2 4163.1 4179.5 4187.1 4192.5 4193.3 4124.0 4149.0 4155.4 4183.0 4183.7 4076.0 4104.7 4105.9 4117.5 4135.6 3562.5 3564.4 3591.5 3594.9 3595.7 5216.8 5218.7 5222.0 5223.7 5225.2 4583.7 4692.7 4697.4 4736.6 4760.0 5503.7 5519.8 5568.8 5585.4 5587.7 4023.2 4051.2 4053.7 4070.2 4073.6 5560.6 5769.3 5776.7 5786.2 5790.2 4125.8 4134.9 4135.9 4137.7 4141.6 4100.8 4182.4 4195.9 4203.1 4217.2 4588.3 4789.1 4796.2 4834.4 4852.1 5552.9 5578.6 5589.9 5611.9 5635.6 1397.6 1405.8 1416.5 1436.4 1443.4 933.2 933.5 951.5 989.9 999.9 5350.2 5515.2 5523.0 5530.9 5555.7 5823.4 5829.3 5867.4 5874.2 5878.9 5194.8 5431.3 5496.8 5497.5 5549.3 2924.6 2947.6 2977.0 2977.7 2983.7 5700.3 5703.8 5792.5 5866.6 5895.4 5696.7 5711.9 5726.5 5741.5 5765.0 5853.8 5876.2 5877.4 5894.8 5905.5 5415.6 5644.0 5673.0 5677.4 5717.9 5553.4 5579.4 5606.2 5618.8 5623.9 5718.5 5778.5 5888.2 5890.5 6005.0 3917.9 3920.1 3928.4 3953.4 3954.2 5656.6 5662.5 5698.9 5708.8 5723.4 5326.2 5481.3 5519.7 5535.7 5549.9 5434.6 5440.7 5467.0 5470.7 5477.3 5360.4 5374.6 5374.8 5400.2 5448.7 5557.9 5561.6 5659.8 5694.8 5711.1 5556.5 5559.4 5571.1 5586.4 5594.2 09:30:14 INFO - PROCESS | 30163 | 09:30:14 INFO - PROCESS | 30163 | [#5] yui.html Cycles:180 Average:17814.22 Median:4682.96 stddev:23058.44 (492.4%) stddev-sans-first:23087.34 09:30:14 INFO - PROCESS | 30163 | Values: 707.8 734.6 739.1 767.8 804.8 14456.4 16425.8 16681.2 16856.5 17628.2 16773.7 16829.7 16847.9 16925.2 16937.4 773.5 808.9 813.8 817.0 817.3 785.2 819.3 819.6 823.8 823.9 849.1 852.1 852.3 855.4 856.7 846.8 849.1 849.3 850.2 850.6 620.0 620.6 621.1 622.2 624.1 14729.3 14941.1 15409.2 15481.5 15593.6 13656.0 13922.2 14264.9 14338.7 14518.0 11350.7 11460.9 11479.8 11769.5 11796.1 3523.7 3574.6 3606.7 3636.9 3653.1 73481.6 73819.3 74251.6 76056.6 76921.2 10900.8 11016.9 11412.5 11502.7 11547.2 20968.0 21304.9 21313.4 21432.0 21452.5 7638.3 7819.6 7890.7 7970.8 8041.7 4561.5 4570.9 4621.4 4743.2 4845.2 3595.2 3664.6 3677.8 3694.8 3735.9 593.5 594.2 611.1 623.2 645.3 649.2 655.3 728.2 755.6 755.8 9523.2 9956.6 10019.1 10115.2 10125.8 614.3 677.6 717.6 727.9 734.8 4362.4 4659.7 4706.2 4724.5 4748.2 81229.0 82477.6 83969.6 84028.6 86443.1 68051.0 69768.7 71794.0 73165.6 75825.6 62964.0 64507.7 66549.0 66732.3 66938.7 9036.7 9102.0 9207.9 9230.2 9234.7 46002.3 46421.3 47269.3 47270.8 47912.0 45362.8 51351.5 59062.7 59166.0 61929.1 11714.2 11791.4 11987.9 12130.9 12968.9 13294.9 13487.9 13591.1 13783.0 14115.6 12586.5 12880.4 13018.4 13219.3 13450.3 12467.4 13067.3 13127.5 13197.9 13497.5 12358.4 12564.9 12978.2 13007.2 13149.0 10467.0 10546.4 10561.4 10603.9 10726.3 10341.3 10600.2 10861.2 11087.3 11301.8 09:30:14 INFO - PROCESS | 30163 | -------- Summary: end -------- 09:30:14 INFO - PROCESS | 30163 | 09:30:15 INFO - TEST-INFO | 30163: exit 0 09:30:15 INFO - TEST-OK | dromaeo_css | took 1117004ms 09:30:15 INFO - TEST-START | kraken 09:30:15 INFO - operating with platform_type : linux_ 09:30:15 INFO - Initialising browser for kraken test... 09:30:15 INFO - TEST-INFO | started process 30525 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ07A5g/profile http://localhost:40846/getInfo.html) 09:30:19 INFO - PROCESS | 30525 | __metrics Screen width/height:1600/1200 09:30:19 INFO - PROCESS | 30525 | colorDepth:24 09:30:19 INFO - PROCESS | 30525 | Browser inner width/height: 1024/697 09:30:19 INFO - PROCESS | 30525 | __metrics 09:30:20 ERROR - PROCESS | 30525 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 09:30:21 INFO - TEST-INFO | 30525: exit 0 09:30:21 INFO - Browser initialized. 09:30:21 INFO - Running cycle 1/1 for kraken test... 09:30:21 INFO - TEST-INFO | started process 30652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ07A5g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:30:33 INFO - PROCESS | 30652 | RSS: Main: 186449920 09:30:33 INFO - PROCESS | 30652 | 09:30:36 INFO - PROCESS | 30652 | Cycle 1(1): loaded http://localhost:40846/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40846/tests/kraken/driver.html?testName=audio-beat-detection) 09:30:37 INFO - PROCESS | 30652 | RSS: Main: 199118848 09:30:37 INFO - PROCESS | 30652 | 09:30:40 INFO - PROCESS | 30652 | Cycle 1(1): loaded http://localhost:40846/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40846/tests/kraken/driver.html?testName=audio-dft) 09:30:40 INFO - PROCESS | 30652 | RSS: Main: 197414912 09:30:40 INFO - PROCESS | 30652 | 09:30:43 INFO - PROCESS | 30652 | Cycle 1(1): loaded http://localhost:40846/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40846/tests/kraken/driver.html?testName=audio-fft) 09:30:44 INFO - PROCESS | 30652 | RSS: Main: 193867776 09:30:44 INFO - PROCESS | 30652 | 09:30:46 INFO - PROCESS | 30652 | Cycle 1(1): loaded http://localhost:40846/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40846/tests/kraken/driver.html?testName=audio-oscillator) 09:30:47 INFO - PROCESS | 30652 | RSS: Main: 194641920 09:30:47 INFO - PROCESS | 30652 | 09:30:49 INFO - PROCESS | 30652 | Cycle 1(1): loaded http://localhost:40846/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40846/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:30:49 INFO - PROCESS | 30652 | RSS: Main: 194658304 09:30:49 INFO - PROCESS | 30652 | 09:30:52 INFO - PROCESS | 30652 | Cycle 1(1): loaded http://localhost:40846/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40846/tests/kraken/driver.html?testName=imaging-darkroom) 09:30:53 INFO - PROCESS | 30652 | RSS: Main: 199970816 09:30:53 INFO - PROCESS | 30652 | 09:30:57 INFO - PROCESS | 30652 | Cycle 1(1): loaded http://localhost:40846/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40846/tests/kraken/driver.html?testName=imaging-desaturate) 09:30:57 INFO - PROCESS | 30652 | RSS: Main: 196100096 09:30:57 INFO - PROCESS | 30652 | 09:31:00 INFO - PROCESS | 30652 | Cycle 1(1): loaded http://localhost:40846/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40846/tests/kraken/driver.html?testName=json-parse-financial) 09:31:01 INFO - PROCESS | 30652 | RSS: Main: 197808128 09:31:01 INFO - PROCESS | 30652 | 09:31:02 INFO - PROCESS | 30652 | Cycle 1(1): loaded http://localhost:40846/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40846/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:31:03 INFO - PROCESS | 30652 | RSS: Main: 197853184 09:31:03 INFO - PROCESS | 30652 | 09:31:05 INFO - PROCESS | 30652 | Cycle 1(1): loaded http://localhost:40846/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40846/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:31:05 INFO - PROCESS | 30652 | RSS: Main: 197935104 09:31:05 INFO - PROCESS | 30652 | 09:31:07 INFO - PROCESS | 30652 | Cycle 1(1): loaded http://localhost:40846/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40846/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:31:08 INFO - PROCESS | 30652 | RSS: Main: 197832704 09:31:08 INFO - PROCESS | 30652 | 09:31:11 INFO - PROCESS | 30652 | Cycle 1(1): loaded http://localhost:40846/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40846/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:31:12 INFO - PROCESS | 30652 | RSS: Main: 198377472 09:31:12 INFO - PROCESS | 30652 | 09:31:14 INFO - PROCESS | 30652 | Cycle 1(1): loaded http://localhost:40846/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40846/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:31:15 INFO - PROCESS | 30652 | RSS: Main: 198057984 09:31:15 INFO - PROCESS | 30652 | 09:31:17 INFO - PROCESS | 30652 | Cycle 1(1): loaded http://localhost:40846/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40846/tests/kraken/driver.html?testName=ai-astar) 09:31:17 INFO - PROCESS | 30652 | RSS: Main: 199860224 09:31:17 INFO - PROCESS | 30652 | 09:31:17 INFO - PROCESS | 30652 | __start_tp_report 09:31:17 INFO - PROCESS | 30652 | _x_x_mozilla_page_load 09:31:17 INFO - PROCESS | 30652 | _x_x_mozilla_page_load_details 09:31:17 INFO - PROCESS | 30652 | |i|pagename|runs| 09:31:17 INFO - PROCESS | 30652 | |0;ai-astar;104;114;113;111;115;116;119;114;114;115 09:31:17 INFO - PROCESS | 30652 | |1;audio-beat-detection;162;128;127;167;132;126;127;126;146;132 09:31:17 INFO - PROCESS | 30652 | |2;audio-dft;163;164;169;170;162;166;164;165;165;163 09:31:17 INFO - PROCESS | 30652 | |3;audio-fft;78;76;77;111;78;81;78;76;95;77 09:31:17 INFO - PROCESS | 30652 | |4;audio-oscillator;84;83;104;84;82;82;102;83;84;119 09:31:17 INFO - PROCESS | 30652 | |5;imaging-gaussian-blur;118;118;118;118;121;119;121;118;119;119 09:31:17 INFO - PROCESS | 30652 | |6;imaging-darkroom;147;149;149;148;148;150;148;149;148;150 09:31:17 INFO - PROCESS | 30652 | |7;imaging-desaturate;97;97;96;97;97;96;97;97;96;97 09:31:17 INFO - PROCESS | 30652 | |8;json-parse-financial;54;53;55;54;54;58;54;57;66;57 09:31:17 INFO - PROCESS | 30652 | |9;json-stringify-tinderbox;62;63;62;63;63;62;63;62;63;62 09:31:17 INFO - PROCESS | 30652 | |10;stanford-crypto-aes;85;83;88;83;82;83;82;88;83;82 09:31:17 INFO - PROCESS | 30652 | |11;stanford-crypto-ccm;136;151;139;149;134;135;145;133;183;142 09:31:17 INFO - PROCESS | 30652 | |12;stanford-crypto-pbkdf2;169;169;168;176;172;171;167;168;165;167 09:31:17 INFO - PROCESS | 30652 | |13;stanford-crypto-sha256-iterative;68;71;68;71;67;73;69;67;68;68 09:31:17 INFO - PROCESS | 30652 | __end_tp_report 09:31:17 INFO - PROCESS | 30652 | __start_cc_report 09:31:17 INFO - PROCESS | 30652 | _x_x_mozilla_cycle_collect,801 09:31:17 INFO - PROCESS | 30652 | __end_cc_report 09:31:17 INFO - PROCESS | 30652 | __startTimestamp1480267877596__endTimestamp 09:31:17 INFO - PROCESS | 30652 | 09:31:17 INFO - PROCESS | 30652 | ------- Summary: start ------- 09:31:17 INFO - PROCESS | 30652 | Number of tests: 14 09:31:17 INFO - PROCESS | 30652 | 09:31:17 INFO - PROCESS | 30652 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.50 stddev:3.92 (3.4%) stddev-sans-first:2.19 09:31:17 INFO - PROCESS | 30652 | Values: 104.0 114.0 113.0 111.0 115.0 116.0 119.0 114.0 114.0 115.0 09:31:17 INFO - PROCESS | 30652 | 09:31:17 INFO - PROCESS | 30652 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:132.00 stddev:15.56 (11.8%) stddev-sans-first:13.69 09:31:17 INFO - PROCESS | 30652 | Values: 162.0 128.0 127.0 167.0 132.0 126.0 127.0 126.0 146.0 132.0 09:31:17 INFO - PROCESS | 30652 | 09:31:17 INFO - PROCESS | 30652 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:2.60 (1.6%) stddev-sans-first:2.65 09:31:17 INFO - PROCESS | 30652 | Values: 163.0 164.0 169.0 170.0 162.0 166.0 164.0 165.0 165.0 163.0 09:31:17 INFO - PROCESS | 30652 | 09:31:17 INFO - PROCESS | 30652 | [#3] audio-fft Cycles:10 Average:82.70 Median:78.00 stddev:11.43 (14.7%) stddev-sans-first:12.00 09:31:17 INFO - PROCESS | 30652 | Values: 78.0 76.0 77.0 111.0 78.0 81.0 78.0 76.0 95.0 77.0 09:31:17 INFO - PROCESS | 30652 | 09:31:17 INFO - PROCESS | 30652 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:83.00 stddev:12.95 (15.6%) stddev-sans-first:13.51 09:31:17 INFO - PROCESS | 30652 | Values: 84.0 83.0 104.0 84.0 82.0 82.0 102.0 83.0 84.0 119.0 09:31:17 INFO - PROCESS | 30652 | 09:31:17 INFO - PROCESS | 30652 | [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:119.00 stddev:1.20 (1.0%) stddev-sans-first:1.22 09:31:17 INFO - PROCESS | 30652 | Values: 118.0 118.0 118.0 118.0 121.0 119.0 121.0 118.0 119.0 119.0 09:31:17 INFO - PROCESS | 30652 | 09:31:17 INFO - PROCESS | 30652 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.97 (0.6%) stddev-sans-first:0.83 09:31:17 INFO - PROCESS | 30652 | Values: 147.0 149.0 149.0 148.0 148.0 150.0 148.0 149.0 148.0 150.0 09:31:17 INFO - PROCESS | 30652 | 09:31:17 INFO - PROCESS | 30652 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:31:17 INFO - PROCESS | 30652 | Values: 97.0 97.0 96.0 97.0 97.0 96.0 97.0 97.0 96.0 97.0 09:31:17 INFO - PROCESS | 30652 | 09:31:17 INFO - PROCESS | 30652 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:3.82 (6.8%) stddev-sans-first:3.97 09:31:17 INFO - PROCESS | 30652 | Values: 54.0 53.0 55.0 54.0 54.0 58.0 54.0 57.0 66.0 57.0 09:31:17 INFO - PROCESS | 30652 | 09:31:17 INFO - PROCESS | 30652 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 09:31:17 INFO - PROCESS | 30652 | Values: 62.0 63.0 62.0 63.0 63.0 62.0 63.0 62.0 63.0 62.0 09:31:17 INFO - PROCESS | 30652 | 09:31:17 INFO - PROCESS | 30652 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.00 stddev:2.33 (2.8%) stddev-sans-first:2.44 09:31:17 INFO - PROCESS | 30652 | Values: 85.0 83.0 88.0 83.0 82.0 83.0 82.0 88.0 83.0 82.0 09:31:17 INFO - PROCESS | 30652 | 09:31:17 INFO - PROCESS | 30652 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:143.50 stddev:14.86 (10.4%) stddev-sans-first:15.42 09:31:17 INFO - PROCESS | 30652 | Values: 136.0 151.0 139.0 149.0 134.0 135.0 145.0 133.0 183.0 142.0 09:31:17 INFO - PROCESS | 30652 | 09:31:17 INFO - PROCESS | 30652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:169.00 stddev:3.12 (1.8%) stddev-sans-first:3.31 09:31:17 INFO - PROCESS | 30652 | Values: 169.0 169.0 168.0 176.0 172.0 171.0 167.0 168.0 165.0 167.0 09:31:17 INFO - PROCESS | 30652 | 09:31:17 INFO - PROCESS | 30652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.50 stddev:2.00 (2.9%) stddev-sans-first:2.09 09:31:17 INFO - PROCESS | 30652 | Values: 68.0 71.0 68.0 71.0 67.0 73.0 69.0 67.0 68.0 68.0 09:31:17 INFO - PROCESS | 30652 | -------- Summary: end -------- 09:31:17 INFO - PROCESS | 30652 | 09:31:18 INFO - TEST-INFO | 30652: exit 0 09:31:18 INFO - TEST-OK | kraken | took 63272ms 09:31:18 INFO - SUITE-END | took 1180s 09:31:19 INFO - Completed test suite (00:19:40) 09:31:19 INFO - javascript benchmark 09:31:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7090.433126194216, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3076.092552696954, 3076.5538996845453, 3087.1356020314306, 3111.2688518198206, 3112.6109236345455, 5269.86825329367, 5336.146216605339, 5364.195370694393, 5421.810236641718, 5436.048691478995, 5403.675779453236, 5469.371022332433, 5523.199136125259, 5530.834074977757, 5579.442055794419, 4886.828960986366, 4973.850784476463, 5007.7496125193775, 5008.373953255843, 5011.674241174312, 4597.539411165984, 5043.949560504403, 5118.129917913963, 5123.743812809364, 5158.845234642967, 5064.696118232881, 5116.079105760961, 5116.283720279164, 5117.795288188468, 5130.38435387754, 4856.538628830255, 4874.098291816025, 4887.804487820483, 4945.901081978376, 4946.530079642428, 4887.780049897763, 4896.706197628154, 4899.0, 4903.632227582945, 4906.533879281463, 5301.204819277139, 5341.1988201769655, 5378.731063446812, 5390.164524498709, 5390.595705322077, 5758.539316854642, 5763.221965034751, 5781.884362312772, 5798.565107616903, 5827.883442331172, 5793.710314484301, 5818.44724751148, 5828.737706803204, 5896.056630939072, 5909.527237820964, 5370.409254981949, 5395.271638328775, 5434.130539113723, 5483.396826349099, 5508.641938274, 5842.941570584239, 5884.117382392676, 5906.852328691731, 5913.02435098204, 5940.168376427304, 5615.185798059259, 5671.51792097668, 5692.23154874095, 5701.287339082614, 5746.9712651436475, 5682.318121825408, 5732.971335143297, 5736.340320863154, 5767.538596912321, 5792.507636850831, 5631.070873305941, 5757.481826635623, 5765.971170144123, 5767.826965191051, 5810.244668193192, 5716.0, 5741.712914354265, 5752.654840709571, 5807.274090738658, 5882.0, 4386.407834942242, 4433.534478879736, 4434.068845542472, 4449.421575195204, 4496.145732310851, 3951.9604803951593, 3969.4641223435046, 3978.8010599469912, 4029.5970402960056, 4033.4353190553347, 5353.411124776271, 5380.838574842761, 5401.378841433286, 5406.0, 5406.8918621627345, 5728.455796699307, 5730.111832665943, 5781.508571771363, 5807.0, 5847.56143289255, 5343.305370301913, 5396.595255355864, 5478.534324582455, 5480.232767412565, 5483.8080667177255, 4839.806407743651, 4967.5777558907175, 4989.55094041538, 5012.874678133003, 5060.949390506122, 5913.172155898264, 6003.459688628044, 6016.849578760391, 6056.909146362808, 6073.028315469592, 5874.324452687995, 5915.319738230159, 5923.4076592340425, 5923.733431995484, 5977.790777322947, 5910.113482977587, 6029.909551356645, 6046.7278972445465, 6047.667378294236, 6062.36345183767, 5494.532964698045, 5523.585731070106, 5569.777208911761, 5754.741036653444, 5770.480656740913, 5720.599558030898, 5720.971395143164, 5726.198332233407, 5741.3397459291045, 5748.54011679073, 5550.361708403585, 5576.721163941867, 5584.078627026495, 5608.747606357642, 5675.148727690715, 5632.464915832989, 5653.971730141488, 5663.490285874126, 5678.119891416837, 5692.089265717465, 5513.393526712139, 5615.410381910004, 5642.689652069175, 5655.886882262414, 5672.829815105553, 5639.7180140993605, 5644.6330988485615, 5667.093265077568, 5677.51741102011, 5721.485066344049, 5584.776608935597, 5592.86017849557, 5598.944010560005, 5602.775888964396, 5656.434356564475], "value": 5341.447136708045, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.5693730421618, 563.385909358799, 572.8367415286644, 572.9283839520061, 585.6837307853757, 39544.40683389751, 41192.17615647689, 41420.17159656805, 44193.55806441935, 44492.0, 42192.0, 42764.572354276446, 42869.57130428695, 42892.0, 42908.570914290845, 8451.239388455038, 8575.871361929576, 8581.742547723547, 8583.914160858374, 10112.089911907964, 9986.751656042994, 10330.690079297596, 10340.482975851215, 10345.741356466111, 10349.223808214376, 10357.533910974023, 10359.741006474824, 10398.740031499236, 10407.739806504822, 10408.0, 10198.0, 10330.793384132312, 10384.0, 10411.635592754294, 10413.281808501588, 10077.244206684529, 10154.0, 10160.390376577428, 10165.135963443116, 10211.234157438223, 39542.60457395418, 39763.60236397628, 40044.59955400438, 40147.39778903319, 40210.39684404707, 3445.12073835381, 3489.023073539413, 3495.73781966351, 3617.8914632561064, 3787.3561494545993, 29244.70755292441, 30476.085717428512, 30561.694383056107, 30621.846890765628, 30834.53748193779, 4056.7971601419813, 4104.733192342518, 4192.5807419258135, 4387.276099443588, 4398.582134697199, 318919.0, 320064.0, 320525.0, 320852.0, 321923.0, 57468.71265643645, 57718.422815772145, 57857.421425786044, 57943.0, 57997.0, 58650.70674646599, 59278.62885484619, 59616.0, 59676.70161649164, 60121.0, 14764.557063287904, 14919.179445130621, 15035.0, 15073.321700523502, 15119.470818521519, 11773.88226117745, 11835.11236657254, 11835.763284734257, 11839.763204735857, 11888.28670279786, 18475.35336263251, 18856.905715471334, 19809.603807923762, 19823.900880495792, 19847.503812404517, 7301.333599720272, 7482.139553951365, 7796.337311328487, 7808.726694565663, 7811.68753249875, 909.2544113826731, 989.5744829723288, 990.4453506036642, 1037.258360272409, 1053.3258714422775, 31470.213244669067, 31639.683603164132, 31781.205469862976, 31819.20451988719, 32024.199395014846, 1048.496721573649, 1093.1364222264322, 1093.147345070846, 1101.2071308657753, 1190.595197632809, 15608.453704120302, 16507.58731031734, 16520.42178523746, 16606.584835379213, 16822.158892055348, 486029.0, 499032.0, 501723.0, 762443.0, 777123.0, 54482.0, 55148.0, 55381.44618553763, 55665.44334556683, 55778.442215578136, 1323.6492329532682, 1335.9198448093146, 1373.3811406942577, 1380.4547203854422, 1381.461230120274, 29404.354867734117, 30982.0, 31497.527537086502, 31856.522152167272, 31961.840190798895, 49070.509294906595, 49130.75434622804, 49831.252531211336, 49831.750841245565, 49844.750776245884, 455401.0, 456656.0, 456929.0, 458167.0, 461511.0, 27249.727502725513, 27867.860660696566, 27994.16017519478, 28070.71929280763, 29680.55479167771, 44742.0, 45275.54724452713, 46108.53891461177, 46143.0, 46478.53521464742, 38691.613083868804, 39202.2159556813, 39417.40873886951, 40349.0, 41040.79479602583, 38396.42405363866, 38648.2270354597, 38873.2225355497, 39420.211595768495, 39764.40353394643, 38117.0, 39411.60588394194, 39515.2096958065, 39876.60123398729, 39891.00272493211, 33556.328873422884, 35624.821875890455, 35713.64286357103, 36183.29617149754, 36325.27349453049, 26868.73131268662, 26888.32779180536, 27016.59475107914, 27307.86346068257, 27401.31496712598], "value": 20050.228279870473, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.09948268207114, 394.4044492815849, 405.0824881643078, 408.06756561257515, 422.9890561557877, 17860.196291166896, 18576.071196440174, 18629.627407451844, 18671.346502872402, 19800.60398792027, 18208.45374638763, 18286.17712202951, 18567.07164641769, 18764.0, 18806.24775008998, 5601.551875849943, 5636.915446268309, 5730.484256416921, 5768.826935191951, 5802.361740208574, 5615.410381909902, 5648.943510564883, 5656.151577263402, 5659.151127330892, 5688.516476099537, 5459.754311056012, 5588.413216612258, 5648.661080335193, 5655.943440565583, 5675.602707810455, 5558.0, 5563.749631266583, 5609.52319052881, 5624.578156638248, 5632.957902787997, 4887.633427492952, 5027.296178535008, 5065.518775716338, 5069.923951140736, 5092.770825312869, 22654.66018009731, 22665.66001509962, 22843.42891427711, 22983.770162298497, 23312.184073557342, 2192.5943700415473, 2297.333773205785, 2515.8490490570443, 2682.329417645589, 2838.446502931929, 9949.955254698298, 10839.783204335949, 11549.422528873607, 14054.0, 14891.404343826342, 1769.7256925176619, 1802.22504323141, 1883.962320753591, 1898.32609423654, 1919.1651631540324, 78589.21410785876, 79941.60029199875, 80084.3877637745, 80632.19367806305, 81828.18171818324, 10409.115225205791, 11118.221724479208, 11269.605563805228, 11315.0, 11362.715932101599, 14091.647708807363, 14106.929465352607, 14141.71716565663, 14166.0, 14287.64280892986, 7260.535743085711, 7806.57063861493, 7869.48848324857, 7906.248906353887, 8070.596470176468, 7483.251674832473, 7521.210272921265, 7701.807454813675, 7744.612769361509, 7771.067471903295, 4289.914201715948, 4407.581279778416, 4509.0, 4545.840895568639, 4612.723236605814, 1897.724829899657, 1969.409177246849, 1986.2849374225268, 1991.4523506035955, 2041.2141325589755, 888.9377743558018, 917.6833992272656, 921.5162039928957, 975.7414285214423, 1040.287403128859, 18187.272509099486, 19259.0, 19515.0, 19705.704414433796, 19788.802111978697, 948.7201275623707, 953.580424613168, 981.5337714585658, 1004.2417974429405, 1005.9638572270572, 10194.184465242763, 10871.891281087088, 10913.727156820984, 10987.725306867393, 11019.614313498989, 373529.0, 373721.0, 375133.0, 376665.0, 382061.0, 67100.0, 84602.0, 85460.0, 90221.54889225512, 95382.0, 974.5224839828433, 1003.6888564545014, 1052.6947185316174, 1055.7835643693024, 1055.7941201465794, 16101.597460063593, 17278.568035799206, 17640.55898602494, 17658.0, 17666.381676641256, 39560.40659390169, 40110.79944600258, 40504.0, 41025.0, 41384.37923431211, 53871.0, 54736.726316368164, 54785.45214547963, 55911.720441397534, 56155.43844561502, 7488.251174882686, 7811.726589569338, 7909.288164065261, 7949.76778599318, 8293.419460637697, 11068.059214966495, 12001.219920705125, 12139.514419423123, 12145.81781273264, 12510.937445312715, 10935.28920620189, 11052.171087168334, 11390.145739069769, 11692.824607630722, 11827.290362578273, 5228.163493840967, 8136.75589732309, 10627.140250456294, 10756.978087081714, 11239.943800280946, 11031.558737650405, 11125.109991200847, 11172.385518796544, 11264.38045907483, 11704.297742135499, 7938.285554300141, 7973.362131029619, 8235.423520353757, 8280.420370574002, 8337.791555211168, 9719.368241064309, 10642.89357106419, 11055.502502387573, 11181.0, 11564.94217528907], "value": 8897.314159830024, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.934707938143, 1456.1481533303017, 1595.9281832317545, 1706.650136721972, 1738.4436980166336, 7562.659680314386, 7617.80955476112, 7752.263534964177, 7760.767176984686, 7899.960500197498, 7985.520868747879, 8266.875996860052, 8277.048139463963, 8372.246497815195, 8511.829763404729, 2173.565286942614, 2208.4920468292303, 2222.3333000099988, 2222.3666255117296, 2229.2866282789514, 2272.0570963050313, 2283.1438210671, 2283.577538155438, 2314.5833749925005, 2324.267855625481, 2155.5257843274453, 2188.387251569563, 2200.460887082659, 2206.735191776989, 2227.3318004598555, 2147.087487817687, 2148.602508535926, 2152.440365504964, 2153.6231159547096, 2161.470439742265, 2176.4667656424117, 2201.889905504718, 2202.174184680745, 2223.1996481266733, 2229.3534874886427, 8364.623591938378, 8468.78828029298, 8529.10444403335, 8556.74329770108, 8571.828563428759, 4977.352944117278, 5067.467915868818, 5096.566791822699, 5114.2840002399325, 5134.589232861399, 3126.5310203469435, 3170.619525656913, 3328.367610154063, 3336.115929278743, 3356.2784001439563, 1084.1760262200785, 1089.477051015509, 1107.3909349857547, 1120.456578559398, 1138.1293310617384, 11669.766604667944, 11702.356370399624, 11828.526858925632, 11829.112816538707, 11874.821877671842, 4334.804933777988, 4350.543192964757, 4531.954680453219, 4535.727856328631, 4560.338750881104, 9876.506174691236, 9901.405915645084, 9903.702888913343, 9904.306698531178, 9923.751906202258, 5100.158473851773, 5124.128898087334, 5149.48505149482, 5151.124308867502, 5160.380754309507, 4445.844080539083, 4602.654800889946, 4653.86038418848, 4743.335932969387, 4755.881102972384, 3535.911602209965, 3572.1248294168095, 3604.675579197885, 3686.612905644922, 3692.335379631692, 1111.1666250312267, 1115.2694984784978, 1127.3461392392392, 1130.2596799096605, 1133.0595605647293, 882.302980645283, 891.7324802559207, 960.7309953213112, 974.0940924939874, 987.4223579206101, 5536.640118392372, 5710.371859095496, 5756.395578464201, 6082.635041897501, 6123.326434092246, 424.280843969475, 432.2543612268874, 435.61012893460173, 436.21263619167706, 437.2370213976631, 3799.2781371539318, 3864.4589757433982, 3871.9806400967814, 3894.0, 3894.6105389460827, 10019.198464122852, 10420.478976051167, 10524.36853788775, 10548.894511054945, 10551.419671918118, 10196.643117490852, 10338.53476593555, 10489.318194317346, 10575.36547807134, 10608.681739547827, 7526.134494533198, 7867.331276841533, 7931.246531579491, 8038.758837234892, 8055.677772889018, 5885.087811389241, 5898.734556944862, 5902.970485147547, 6046.969765151146, 6065.484433822998, 9361.765955851159, 9451.196648284698, 9585.0, 9598.088181622734, 9642.903570964201, 9283.582238799405, 9560.808783824423, 9561.948185699706, 9687.903120968982, 9733.172680321968, 7229.277072292729, 7284.307990740871, 7416.851662966818, 7486.326230639269, 7581.54510729358, 8170.673173073011, 8180.46826956246, 8192.918070819454, 8204.0, 8260.628271727666, 7075.646217689198, 7218.0, 7334.376577990931, 7381.704731810667, 7427.962860185665, 7148.106486689164, 7171.892421613576, 7212.134543854771, 7309.378702810321, 7529.8117547061765, 6668.166479190101, 6711.261761206166, 6719.596824190564, 6787.151606049244, 6805.183377994672, 4994.275830004702, 5041.369828771403, 5113.769880355468, 5250.133727935001, 5256.474352564713, 5101.311322971352, 5152.124138896322, 5211.348581427322, 5226.843194704165, 5316.521513063843], "value": 4360.14499223249, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.6567243196268, 316.5742076906561, 316.6722442272249, 320.44882801581304, 326.07557574276916, 5369.194620806881, 5416.539594134493, 5423.376311724148, 5423.91864122038, 5435.374931882835, 5170.9482905170935, 5339.599530035253, 5342.946570534294, 5347.262139804559, 5382.515573598375, 4029.4560234368423, 4088.8977775555627, 4173.269677806387, 4182.91634167318, 4200.201961627296, 4163.084121493267, 4179.456670632813, 4187.1416359646355, 4192.517860446042, 4193.259797184165, 4123.969007748063, 4148.958510414903, 4155.376693495985, 4182.996080940583, 4183.728057676241, 4076.0, 4104.651104656108, 4105.91788164235, 4117.547069822317, 4135.58644135587, 3562.5012498250267, 3564.3940530109944, 3591.479235510836, 3594.856205751767, 3595.7303202259936, 5216.7913283468615, 5218.66078704883, 5222.0, 5223.71269580173, 5225.242339860699, 4583.656225783079, 4692.671512994092, 4697.436307643105, 4736.6447516436065, 4759.976200119012, 5503.669779813224, 5519.834404967817, 5568.805091821767, 5585.441455854423, 5587.720613969326, 4023.195360927797, 4051.189762047573, 4053.716239863211, 4070.2470043041835, 4073.6130067643526, 5560.555155587584, 5769.278840144982, 5776.653400795965, 5786.222613145714, 5790.247267855194, 4125.773082480492, 4134.855280065243, 4135.875923722293, 4137.710360274812, 4141.585841415835, 4100.753954762724, 4182.393552934868, 4195.8741237762915, 4203.108601129504, 4217.240896638573, 4588.311753236974, 4789.114013907439, 4796.160671882407, 4834.444038935497, 4852.126617208936, 5552.91670624941, 5578.581606379537, 5589.888202235932, 5611.887762244733, 5635.605507614428, 1397.6296281485415, 1405.845357010728, 1416.5055866061198, 1436.3823555870867, 1443.4082026369138, 933.178802653674, 933.487749845255, 951.5004622573205, 989.9010098990043, 999.8500224966314, 5350.197470379397, 5515.172724091419, 5522.972385138049, 5530.944690553123, 5555.666660000413, 5823.4467725566, 5829.329627092854, 5867.442592953663, 5874.179004508616, 5878.882422351529, 5194.792208311701, 5431.321084864392, 5496.835094947158, 5497.4607110009265, 5549.334079910436, 2924.6164376033466, 2947.6462824460773, 2976.9702302976693, 2977.702229777048, 2983.686712895115, 5700.344460387026, 5703.828885133453, 5792.507636850914, 5866.560007999417, 5895.35151133375, 5696.743646535916, 5711.8857622848145, 5726.455986681259, 5741.5119714824705, 5764.971175144181, 5853.765849366063, 5876.206712093898, 5877.441643043904, 5894.793682221101, 5905.464579209351, 5415.566754659697, 5644.0, 5673.0, 5677.445149682577, 5717.914231286451, 5553.389127195925, 5579.358373787067, 5606.24315717373, 5618.803341883015, 5623.859403514781, 5718.513926316144, 5778.526475748826, 5888.205092312654, 5890.52875769946, 6004.969975150097, 3917.9020524485977, 3920.137569734654, 3928.3893603622378, 3953.4069889515654, 3954.2289253596423, 5656.575756818337, 5662.490375866192, 5698.857528561653, 5708.80019199326, 5723.370429252695, 5326.242340027859, 5481.287432633732, 5519.724013799214, 5535.671438854565, 5549.861253468695, 5434.619576629598, 5440.727963601725, 5466.972665136649, 5470.671759694431, 5477.3427188737605, 5360.356757189163, 5374.570034397317, 5374.838754837361, 5400.2439658447065, 5448.673079615236, 5557.943990641765, 5561.610687251854, 5659.801906933238, 5694.829155125353, 5711.087904785069, 5556.499915007668, 5559.416261292506, 5571.13647384656, 5586.413426590312, 5594.1608758686525], "value": 4247.461491311688, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.766437075765, 734.5555938657112, 739.0650826704224, 767.8042099264691, 804.7666176808726, 14456.421743130275, 16425.83574164258, 16681.165941702926, 16856.49430517085, 17628.20673069712, 16773.664526709457, 16829.66340673186, 16847.915760421212, 16925.238364273606, 16937.407190748327, 773.5126870071861, 808.8867558541809, 813.8209593889335, 816.9714060007901, 817.264461984213, 785.1520358013361, 819.3281509162489, 819.647551552832, 823.8022874510134, 823.9382046346518, 849.0914721248236, 852.1478521478522, 852.3181454836138, 855.4012191465968, 856.7087190355278, 846.8179341441589, 849.0660273698943, 849.2569002123142, 850.2475309351207, 850.6342272822684, 619.9628022318631, 620.5501011766478, 621.0839012456636, 622.1973653986353, 624.1168746224088, 14729.337179826933, 14941.103533788008, 15409.152496612682, 15481.458148964732, 15593.610159745984, 13656.0, 13922.234277114754, 14264.85735142656, 14338.713225735532, 14518.0, 11350.659480215525, 11460.94269528647, 11479.827802582968, 11769.529218831321, 11796.115291353182, 3523.6828685418436, 3574.6246644102257, 3606.6934310583633, 3636.9272614547826, 3653.12325041988, 73481.63259183723, 73819.26180738177, 74251.62874185649, 76056.61971690106, 76921.23078769197, 10900.836487452694, 11016.944915275533, 11412.543498260142, 11502.654920352235, 11547.249428787101, 20968.0, 21304.893475532524, 21313.360599182048, 21432.0, 21452.463688407603, 7638.274363935418, 7819.569923654253, 7890.723824666109, 7970.84058318842, 8041.718539851077, 4561.475430325489, 4570.9314360284625, 4621.353010578522, 4743.217369134123, 4845.176320025534, 3595.2449985502813, 3664.5602527696847, 3677.7977211253638, 3694.833732482045, 3735.9066023349633, 593.4807043836643, 594.2215697436372, 611.1321922869536, 623.2489849731063, 645.3449748505271, 649.217692680319, 655.2562841175301, 728.191707205002, 755.6335177438938, 755.8261599831959, 9523.19052880513, 9956.551955162035, 10019.148372388283, 10115.241356898116, 10125.797484050425, 614.3303798859265, 677.5832862789349, 717.6375930155239, 727.9235680253603, 734.8236423258379, 4362.432883725095, 4659.697119687209, 4706.223473126965, 4724.503927087675, 4748.240281555004, 81229.0, 82477.58761206275, 83969.58015209885, 84028.57985710155, 86443.13556864476, 68051.0, 69768.6511567449, 71794.0, 73165.6341718288, 75825.62087189528, 62964.0, 64507.67746161333, 66549.00529476185, 66732.33267667261, 66938.66530667315, 9036.728898133066, 9101.954490227772, 9207.907920920972, 9230.169284764403, 9234.722958311262, 46002.30996534988, 46421.30368044414, 47269.2909606363, 47270.76364618155, 47912.04175916532, 45362.77318613518, 51351.48648513616, 59062.704686476296, 59166.0, 61929.071063933174, 11714.23857449263, 11791.35147566892, 11987.880121198676, 12130.939345303217, 12968.870311297143, 13294.904151048497, 13487.932560337136, 13591.116577422436, 13783.0, 14115.647108822362, 12586.496540138292, 12880.420381082686, 13018.414171362501, 13219.272939988394, 13450.26023568674, 12467.438965246767, 13067.34663266814, 13127.540536081191, 13197.868021319664, 13497.539871894938, 12358.382080896099, 12564.87435125637, 12978.221306721627, 13007.219566826021, 13149.0, 10466.975931021441, 10546.36721796664, 10561.419121948367, 10603.8939610606, 10726.302790318605, 10341.276110672181, 10600.204984626029, 10861.185411094042, 11087.33475991443, 11301.830472542753], "value": 7199.835822400662, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 111.0, 115.0, 116.0, 119.0, 114.0, 114.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 128.0, 127.0, 167.0, 132.0, 126.0, 127.0, 126.0, 146.0, 132.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 169.0, 170.0, 162.0, 166.0, 164.0, 165.0, 165.0, 163.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 77.0, 111.0, 78.0, 81.0, 78.0, 76.0, 95.0, 77.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 104.0, 84.0, 82.0, 82.0, 102.0, 83.0, 84.0, 119.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 121.0, 119.0, 121.0, 118.0, 119.0, 119.0], "value": 118.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 149.0, 148.0, 148.0, 150.0, 148.0, 149.0, 148.0, 150.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 97.0, 97.0, 96.0, 97.0, 97.0, 96.0, 97.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 55.0, 54.0, 54.0, 58.0, 54.0, 57.0, 66.0, 57.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 63.0, 62.0, 63.0, 62.0, 63.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 88.0, 83.0, 82.0, 83.0, 82.0, 88.0, 83.0, 82.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 151.0, 139.0, 149.0, 134.0, 135.0, 145.0, 133.0, 183.0, 142.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 168.0, 176.0, 172.0, 171.0, 167.0, 168.0, 165.0, 167.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 68.0, 71.0, 67.0, 73.0, 69.0, 67.0, 68.0, 68.0], "value": 69.0, "unit": "score"}]}]} 09:31:19 INFO - Return code: 0 09:31:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:31:19 ERROR - # TBPL SUCCESS # 09:31:19 INFO - Running post-action listener: _resource_record_post_action 09:31:19 INFO - [mozharness: 2016-11-27 17:31:19.422367Z] Finished run-tests step (success) 09:31:19 INFO - Running post-run listener: _resource_record_post_run 09:31:19 INFO - Total resource usage - Wall time: 1198s; CPU: 14.0%; Read bytes: 8192; Write bytes: 403808256; Read time: 40; Write time: 263732 09:31:19 INFO - TinderboxPrint: CPU usage
13.5% 09:31:19 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 40 09:31:19 INFO - TinderboxPrint: I/O write bytes / time
403,808,256 / 263,732 09:31:19 INFO - TinderboxPrint: CPU idle
8,260.8 (86.5%) 09:31:19 INFO - TinderboxPrint: CPU user
1,226.9 (12.8%) 09:31:19 INFO - TinderboxPrint: Swap in / out
0 / 0 09:31:19 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115380224; Read time: 0; Write time: 72816 09:31:19 INFO - run-tests - Wall time: 1181s; CPU: 14.0%; Read bytes: 4096; Write bytes: 288428032; Read time: 36; Write time: 190916 09:31:20 INFO - Running post-run listener: _upload_blobber_files 09:31:20 INFO - Blob upload gear active. 09:31:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:31:20 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 09:31:20 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:31:20 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:31:20 INFO - (blobuploader) - INFO - Open directory for files ... 09:31:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:31:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:31:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:21 INFO - (blobuploader) - INFO - Done attempting. 09:31:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:31:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:31:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:24 INFO - (blobuploader) - INFO - Done attempting. 09:31:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:31:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:31:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:25 INFO - (blobuploader) - INFO - Done attempting. 09:31:25 INFO - (blobuploader) - INFO - Iteration through files over. 09:31:25 INFO - Return code: 0 09:31:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:31:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:31:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0d1251f79641eaee7b758f35e1f7bba7e90adde3cdfe31ad659704b02ff8f3e88046dc93851678f4e270e1d8e5ffd1c7c987a8dd91edc93f1f137cadcd8b0da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0d411243ae538c7faf5e5f9db8016909f25833aed8561d80e9c1a7ec96302a313ba142d8dabfb123baf11c0acaa9bbcc242d028892a2d733bad5ba4fc7c26895", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0dce682e1f03668b05ad3cc36f13a2fc8ce6bfa02215a1273719255dab42c104b46785e214c4b02483ed9f1021c940005d9af6a6a55274ed9aac9066147c015a"} 09:31:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:31:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:31:25 INFO - Contents: 09:31:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0d1251f79641eaee7b758f35e1f7bba7e90adde3cdfe31ad659704b02ff8f3e88046dc93851678f4e270e1d8e5ffd1c7c987a8dd91edc93f1f137cadcd8b0da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0d411243ae538c7faf5e5f9db8016909f25833aed8561d80e9c1a7ec96302a313ba142d8dabfb123baf11c0acaa9bbcc242d028892a2d733bad5ba4fc7c26895", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0dce682e1f03668b05ad3cc36f13a2fc8ce6bfa02215a1273719255dab42c104b46785e214c4b02483ed9f1021c940005d9af6a6a55274ed9aac9066147c015a"} 09:31:25 INFO - Running post-run listener: copy_logs_to_upload_dir 09:31:25 INFO - Copying logs to upload dir... 09:31:25 INFO - mkdir: /builds/slave/test/build/upload/logs 09:31:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.024127 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-11-27 09:31:20.646953) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-27 09:31:20.650667) ========= 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=52faae308a556c440401f8e5000001e8-1480255321.703855-417090065 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/Mozilla-Inbound/sha512/e0d1251f79641eaee7b758f35e1f7bba7e90adde3cdfe31ad659704b02ff8f3e88046dc93851678f4e270e1d8e5ffd1c7c987a8dd91edc93f1f137cadcd8b0da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0d411243ae538c7faf5e5f9db8016909f25833aed8561d80e9c1a7ec96302a313ba142d8dabfb123baf11c0acaa9bbcc242d028892a2d733bad5ba4fc7c26895", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0dce682e1f03668b05ad3cc36f13a2fc8ce6bfa02215a1273719255dab42c104b46785e214c4b02483ed9f1021c940005d9af6a6a55274ed9aac9066147c015a"} build_url:https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011421 build_url: 'https://queue.taskcluster.net/v1/task/E6vne_cER1-hAZFarf1uTQ/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/Mozilla-Inbound/sha512/e0d1251f79641eaee7b758f35e1f7bba7e90adde3cdfe31ad659704b02ff8f3e88046dc93851678f4e270e1d8e5ffd1c7c987a8dd91edc93f1f137cadcd8b0da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0d411243ae538c7faf5e5f9db8016909f25833aed8561d80e9c1a7ec96302a313ba142d8dabfb123baf11c0acaa9bbcc242d028892a2d733bad5ba4fc7c26895", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0dce682e1f03668b05ad3cc36f13a2fc8ce6bfa02215a1273719255dab42c104b46785e214c4b02483ed9f1021c940005d9af6a6a55274ed9aac9066147c015a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-27 09:31:20.678971) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-11-27 09:31:20.679327) ========= 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=52faae308a556c440401f8e5000001e8-1480255321.703855-417090065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 1.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-11-27 09:31:21.694984) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-27 09:31:21.695385) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-27 09:31:21.695926) ========= ========= Total master_lag: 1.11 =========