builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1484130699.65 results: success (0) buildid: 20170111004018 builduid: 0626c5a0890b4f0088069ee0fcd2b4e9 revision: 5cf9f0f65d201fc4631530c8f00e3a14887c1ad1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 02:31:39.646697) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 02:31:39.647193) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 02:31:39.647512) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 02:31:39.665042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 02:31:39.665501) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-11 02:31:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2017-01-11 02:31:40 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.264830 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 02:31:39.945052) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 02:31:39.945425) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018589 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 02:31:39.997871) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-11 02:31:39.998668) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5cf9f0f65d201fc4631530c8f00e3a14887c1ad1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5cf9f0f65d201fc4631530c8f00e3a14887c1ad1 --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=5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-11 02:31:40,902 truncating revision to first 12 chars 2017-01-11 02:31:40,902 Setting DEBUG logging. 2017-01-11 02:31:40,902 attempt 1/10 2017-01-11 02:31:40,902 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5cf9f0f65d20?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-11 02:31:42,044 unpacking tar archive at: mozilla-aurora-5cf9f0f65d20/testing/mozharness/ program finished with exit code 0 elapsedTime=1.439595 ========= master_lag: 0.68 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-11 02:31:42.120638) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 02:31:42.121049) ========= script_repo_revision: 5cf9f0f65d201fc4631530c8f00e3a14887c1ad1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 02:31:42.121499) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 02:31:42.121805) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 02:31:42.138272) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-11 02:31:42.138630) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:31:43 INFO - MultiFileLogger online at 20170111 02:31:43 in /builds/slave/test 02:31:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:31:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:31:43 INFO - {'append_to_log': False, 02:31:43 INFO - 'base_work_dir': '/builds/slave/test', 02:31:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:31:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:31:43 INFO - 'branch': 'Mozilla-Aurora', 02:31:43 INFO - 'buildbot_json_path': 'buildprops.json', 02:31:43 INFO - 'config_files': ('talos/linux_config.py',), 02:31:43 INFO - 'default_actions': ('clobber', 02:31:43 INFO - 'read-buildbot-config', 02:31:43 INFO - 'download-and-extract', 02:31:43 INFO - 'populate-webroot', 02:31:43 INFO - 'create-virtualenv', 02:31:43 INFO - 'install', 02:31:43 INFO - 'run-tests'), 02:31:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:31:43 INFO - 'download_minidump_stackwalk': True, 02:31:43 INFO - 'download_symbols': 'ondemand', 02:31:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:31:43 INFO - 'tooltool.py': '/tools/tooltool.py', 02:31:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:31:43 INFO - '/tools/misc-python/virtualenv.py')}, 02:31:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:31:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:31:43 INFO - 'installer_path': 'installer.exe', 02:31:43 INFO - 'log_level': 'info', 02:31:43 INFO - 'log_name': 'talos', 02:31:43 INFO - 'log_to_console': True, 02:31:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:31:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:31:43 INFO - 'opt_config_files': (), 02:31:43 INFO - 'pip_index': False, 02:31:43 INFO - 'sps_profile': False, 02:31:43 INFO - 'sps_profile_interval': 0, 02:31:43 INFO - 'suite': 'dromaeojs-e10s', 02:31:43 INFO - 'system_bits': '32', 02:31:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:31:43 INFO - 'title': 'talos-linux64-ix-051', 02:31:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:31:43 INFO - 'use_talos_json': True, 02:31:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:31:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:31:43 INFO - 'work_dir': 'build'} 02:31:43 INFO - [mozharness: 2017-01-11 10:31:43.142617Z] Running clobber step. 02:31:43 INFO - Running pre-action listener: _resource_record_pre_action 02:31:43 INFO - Running main action method: clobber 02:31:43 INFO - rmtree: /builds/slave/test/build 02:31:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:31:44 INFO - Running post-action listener: _resource_record_post_action 02:31:44 INFO - [mozharness: 2017-01-11 10:31:44.123701Z] Finished clobber step (success) 02:31:44 INFO - [mozharness: 2017-01-11 10:31:44.123800Z] Running read-buildbot-config step. 02:31:44 INFO - Running pre-action listener: _resource_record_pre_action 02:31:44 INFO - Running main action method: read_buildbot_config 02:31:44 INFO - Using buildbot properties: 02:31:44 INFO - { 02:31:44 INFO - "project": "", 02:31:44 INFO - "product": "firefox", 02:31:44 INFO - "script_repo_revision": "production", 02:31:44 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 02:31:44 INFO - "repository": "", 02:31:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 02:31:44 INFO - "buildid": "20170111004018", 02:31:44 INFO - "stage_platform": "linux64-pgo", 02:31:44 INFO - "basedir": "/builds/slave/test", 02:31:44 INFO - "nightly_build": "True", 02:31:44 INFO - "buildnumber": 732, 02:31:44 INFO - "slavename": "talos-linux64-ix-051", 02:31:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:31:44 INFO - "platform": "ubuntu64_hw", 02:31:44 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:31:44 INFO - "branch": "mozilla-aurora", 02:31:44 INFO - "repo_path": "releases/mozilla-aurora", 02:31:44 INFO - "revision": "5cf9f0f65d201fc4631530c8f00e3a14887c1ad1", 02:31:44 INFO - "pgo_build": "True", 02:31:44 INFO - "builduid": "0626c5a0890b4f0088069ee0fcd2b4e9", 02:31:44 INFO - "slavebuilddir": "test" 02:31:44 INFO - } 02:31:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 02:31:44 INFO - Running post-action listener: _resource_record_post_action 02:31:44 INFO - [mozharness: 2017-01-11 10:31:44.126849Z] Finished read-buildbot-config step (success) 02:31:44 INFO - [mozharness: 2017-01-11 10:31:44.126937Z] Running download-and-extract step. 02:31:44 INFO - Running pre-action listener: _resource_record_pre_action 02:31:44 INFO - Running main action method: download_and_extract 02:31:44 INFO - mkdir: /builds/slave/test/build/tests 02:31: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')]} 02:31:44 INFO - trying https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:31:44 INFO - Downloading https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:31:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:31:44 INFO - Downloaded 1361 bytes. 02:31:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:31:44 INFO - Using the following test package requirements: 02:31:44 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:31:44 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:31:44 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:31:44 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:44 INFO - u'jsshell-linux-x86_64.zip'], 02:31:44 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:31:44 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:31:44 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:31:44 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:31:44 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:31:44 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:31:44 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:31:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:31:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:31:44 INFO - Fetch https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:31:45 INFO - Http code: 200 02:31:45 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 02:31:45 INFO - x-amz-cf-id: YCiGs3q-9XCHuWmofnlSZja1sF8HIz5yhHHeES_YPTxJ5VwmIQ_G8Q== 02:31:45 INFO - x-amz-version-id: Tm_Tk7qmFpmJPsQK2RdraPT26Ka20EMO 02:31:45 INFO - Expected file size: 21943488 02:31:45 INFO - Obtained file size: 21943488 02:31:49 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:31:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:31:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:31:49 INFO - Fetch https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:31:50 INFO - Http code: 200 02:31:50 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 02:31:50 INFO - x-amz-cf-id: 2rzgmyTv_SKEgumv1X8Wt96C6IaJxnkWA4XbJxCKuCWMIKdNnqnvoQ== 02:31:50 INFO - x-amz-version-id: Tm_Tk7qmFpmJPsQK2RdraPT26Ka20EMO 02:31:50 INFO - Expected file size: 21943488 02:31:50 INFO - Obtained file size: 21943488 02:31:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 02:31:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:31:54 INFO - Fetch https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 02:31:55 INFO - Http code: 200 02:31:55 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 02:31:55 INFO - x-amz-cf-id: EDIXOGa0hyyQLBXaXOjFNeGjl7QPHwsknhplhtVnTcIsnj-WIMA6hw== 02:31:55 INFO - x-amz-version-id: DWGxosvByMJq9xC7OCQcO1LysGp8Lh8A 02:31:55 INFO - Expected file size: 14409038 02:31:55 INFO - Obtained file size: 14409038 02:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:55 INFO - trying https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:31:55 INFO - Downloading https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:31:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:31:56 INFO - Downloaded 64068977 bytes. 02:31:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:31:56 INFO - mkdir: /builds/slave/test/properties 02:31:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:31:56 INFO - Writing to file /builds/slave/test/properties/build_url 02:31:56 INFO - Contents: 02:31:56 INFO - build_url:https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:31:57 INFO - Running post-action listener: _resource_record_post_action 02:31:57 INFO - Running post-action listener: set_extra_try_arguments 02:31:57 INFO - [mozharness: 2017-01-11 10:31:57.572877Z] Finished download-and-extract step (success) 02:31:57 INFO - [mozharness: 2017-01-11 10:31:57.573104Z] Running populate-webroot step. 02:31:57 INFO - Running pre-action listener: _resource_record_pre_action 02:31:57 INFO - Running main action method: populate_webroot 02:31:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:31:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:31:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:31:57 INFO - '--tppagecycles', 02:31:57 INFO - '7'], 02:31:57 INFO - 'tests': ['tsvgm']}}, 02:31:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:31:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:31:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:31:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:31:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:31:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:31:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:57 INFO - 'talos_options': ['--disable-e10s'], 02:31:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:31:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:31:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:57 INFO - 'talos_options': ['--disable-e10s'], 02:31:57 INFO - 'tests': ['damp', 'tps']}, 02:31:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:57 INFO - 'tests': ['damp', 'tps']}, 02:31:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:31:57 INFO - 'tests': ['dromaeo_dom']}, 02:31:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:31:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:31:57 INFO - 'tests': ['basic_compositor_video']}, 02:31:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:31:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:31:57 INFO - 'tests': ['a11yr', 02:31:57 INFO - 'ts_paint', 02:31:57 INFO - 'tpaint', 02:31:57 INFO - 'sessionrestore', 02:31:57 INFO - 'sessionrestore_no_auto_restore', 02:31:57 INFO - 'tabpaint']}, 02:31:57 INFO - 'other-e10s': {'tests': ['a11yr', 02:31:57 INFO - 'ts_paint', 02:31:57 INFO - 'tpaint', 02:31:57 INFO - 'sessionrestore', 02:31:57 INFO - 'sessionrestore_no_auto_restore', 02:31:57 INFO - 'tabpaint']}, 02:31:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:31:57 INFO - 'ts_paint', 02:31:57 INFO - 'tpaint', 02:31:57 INFO - 'sessionrestore', 02:31:57 INFO - 'sessionrestore_no_auto_restore', 02:31:57 INFO - 'tabpaint']}, 02:31:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:31:57 INFO - 'ts_paint', 02:31:57 INFO - 'tpaint', 02:31:57 INFO - 'sessionrestore', 02:31:57 INFO - 'sessionrestore_no_auto_restore', 02:31:57 INFO - 'tabpaint']}, 02:31:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:31:57 INFO - 'tests': ['a11yr', 02:31:57 INFO - 'ts_paint', 02:31:57 INFO - 'tpaint', 02:31:57 INFO - 'sessionrestore', 02:31:57 INFO - 'sessionrestore_no_auto_restore', 02:31:57 INFO - 'tabpaint']}, 02:31:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:31:57 INFO - 'tests': ['a11yr', 02:31:57 INFO - 'ts_paint', 02:31:57 INFO - 'tpaint', 02:31:57 INFO - 'sessionrestore', 02:31:57 INFO - 'sessionrestore_no_auto_restore', 02:31:57 INFO - 'tabpaint']}, 02:31:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:31:57 INFO - 'tests': ['tsvgx', 02:31:57 INFO - 'tsvgr_opacity', 02:31:57 INFO - 'tart', 02:31:57 INFO - 'tscrollx', 02:31:57 INFO - 'cart']}, 02:31:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:31:57 INFO - 'tsvgr_opacity', 02:31:57 INFO - 'tart', 02:31:57 INFO - 'tscrollx', 02:31:57 INFO - 'cart']}, 02:31:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:57 INFO - 'talos_options': ['--disable-e10s'], 02:31:57 INFO - 'tests': ['tp5o']}, 02:31:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:57 INFO - 'tests': ['tp5o']}, 02:31:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:57 INFO - 'talos_options': ['--disable-e10s', 02:31:57 INFO - '--xperf_path', 02:31:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:31:57 INFO - 'tests': ['tp5n']}, 02:31:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:57 INFO - 'talos_options': ['--xperf_path', 02:31:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:31:57 INFO - 'tests': ['tp5n']}}, 02:31:57 INFO - 'talos.zip': {'path': '', 02:31:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:31:57 INFO - Running post-action listener: _resource_record_post_action 02:31:57 INFO - [mozharness: 2017-01-11 10:31:57.594009Z] Finished populate-webroot step (success) 02:31:57 INFO - [mozharness: 2017-01-11 10:31:57.594097Z] Running create-virtualenv step. 02:31:57 INFO - Running pre-action listener: _resource_record_pre_action 02:31:57 INFO - Running main action method: create_virtualenv 02:31:57 INFO - Creating virtualenv /builds/slave/test/build/venv 02:31:57 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 02:31:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:31:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:31:57 INFO - Using real prefix '/usr' 02:31:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:31:58 INFO - Installing distribute.............................................................................................................................................................................................done. 02:32:00 INFO - Installing pip.................done. 02:32:00 INFO - Return code: 0 02:32:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:32:00 INFO - Reading from file tmpfile_stdout 02:32:00 INFO - Output received: 02:32:00 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) 02:32:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f243ff63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cef60>, '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 0x27cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d01d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', '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 02:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:32:00 INFO - Using env: {'DISPLAY': ':0', 02:32:00 INFO - 'HOME': '/home/cltbld', 02:32:00 INFO - 'LANG': 'en_US.UTF-8', 02:32:00 INFO - 'LANGUAGE': 'en_US:en', 02:32:00 INFO - 'LOGNAME': 'cltbld', 02:32:00 INFO - 'MAIL': '/var/mail/cltbld', 02:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:00 INFO - 'MOZ_NO_REMOTE': '1', 02:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:00 INFO - 'NO_EM_RESTART': '1', 02:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:00 INFO - 'PWD': '/builds/slave/test', 02:32:00 INFO - 'SHELL': '/bin/bash', 02:32:00 INFO - 'SHLVL': '1', 02:32:00 INFO - 'TERM': 'linux', 02:32:00 INFO - 'TMOUT': '86400', 02:32:00 INFO - 'USER': 'cltbld', 02:32:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', 02:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:00 INFO - '_': '/tools/buildbot/bin/python'} 02:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:00 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 02:32:00 INFO - Cleaning up... 02:32:00 INFO - Return code: 0 02:32:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f243ff63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cef60>, '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 0x27cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d01d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', '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 02:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:32:00 INFO - Using env: {'DISPLAY': ':0', 02:32:00 INFO - 'HOME': '/home/cltbld', 02:32:00 INFO - 'LANG': 'en_US.UTF-8', 02:32:00 INFO - 'LANGUAGE': 'en_US:en', 02:32:00 INFO - 'LOGNAME': 'cltbld', 02:32:00 INFO - 'MAIL': '/var/mail/cltbld', 02:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:00 INFO - 'MOZ_NO_REMOTE': '1', 02:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:00 INFO - 'NO_EM_RESTART': '1', 02:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:00 INFO - 'PWD': '/builds/slave/test', 02:32:00 INFO - 'SHELL': '/bin/bash', 02:32:00 INFO - 'SHLVL': '1', 02:32:00 INFO - 'TERM': 'linux', 02:32:00 INFO - 'TMOUT': '86400', 02:32:00 INFO - 'USER': 'cltbld', 02:32:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', 02:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:00 INFO - '_': '/tools/buildbot/bin/python'} 02:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:00 INFO - Downloading/unpacking psutil>=3.1.1 02:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:32:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:02 INFO - Installing collected packages: psutil 02:32:02 INFO - Running setup.py install for psutil 02:32:03 INFO - building 'psutil._psutil_linux' extension 02:32: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 02:32:03 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 02:32:03 INFO - building 'psutil._psutil_posix' extension 02:32:03 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 02:32:03 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 02:32:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:03 INFO - Successfully installed psutil 02:32:03 INFO - Cleaning up... 02:32:03 INFO - Return code: 0 02:32:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f243ff63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cef60>, '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 0x27cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d01d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', '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 02:32:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:32:03 INFO - Using env: {'DISPLAY': ':0', 02:32:03 INFO - 'HOME': '/home/cltbld', 02:32:03 INFO - 'LANG': 'en_US.UTF-8', 02:32:03 INFO - 'LANGUAGE': 'en_US:en', 02:32:03 INFO - 'LOGNAME': 'cltbld', 02:32:03 INFO - 'MAIL': '/var/mail/cltbld', 02:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:03 INFO - 'MOZ_NO_REMOTE': '1', 02:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:03 INFO - 'NO_EM_RESTART': '1', 02:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:03 INFO - 'PWD': '/builds/slave/test', 02:32:03 INFO - 'SHELL': '/bin/bash', 02:32:03 INFO - 'SHLVL': '1', 02:32:03 INFO - 'TERM': 'linux', 02:32:03 INFO - 'TMOUT': '86400', 02:32:03 INFO - 'USER': 'cltbld', 02:32:03 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', 02:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:03 INFO - '_': '/tools/buildbot/bin/python'} 02:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:32:05 INFO - Installing collected packages: mozsystemmonitor 02:32:05 INFO - Running setup.py install for mozsystemmonitor 02:32:05 INFO - Successfully installed mozsystemmonitor 02:32:05 INFO - Cleaning up... 02:32:05 INFO - Return code: 0 02:32:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:32:05 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')]} 02:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:05 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')]} 02:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:05 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 0x7f243ff63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cef60>, '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 0x27cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d01d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', '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 02:32:05 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 02:32:05 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 02:32:05 INFO - Using env: {'DISPLAY': ':0', 02:32:05 INFO - 'HOME': '/home/cltbld', 02:32:05 INFO - 'LANG': 'en_US.UTF-8', 02:32:05 INFO - 'LANGUAGE': 'en_US:en', 02:32:05 INFO - 'LOGNAME': 'cltbld', 02:32:05 INFO - 'MAIL': '/var/mail/cltbld', 02:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:05 INFO - 'MOZ_NO_REMOTE': '1', 02:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:05 INFO - 'NO_EM_RESTART': '1', 02:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:05 INFO - 'PWD': '/builds/slave/test', 02:32:05 INFO - 'SHELL': '/bin/bash', 02:32:05 INFO - 'SHLVL': '1', 02:32:05 INFO - 'TERM': 'linux', 02:32:05 INFO - 'TMOUT': '86400', 02:32:05 INFO - 'USER': 'cltbld', 02:32:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', 02:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:05 INFO - '_': '/tools/buildbot/bin/python'} 02:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:06 INFO - Downloading/unpacking jsonschema==2.5.1 02:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:32:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32:08 INFO - Downloading functools32-3.2.3-2.tar.gz 02:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:32:08 INFO - warning: no files found matching '*.txt' 02:32:08 INFO - no previously-included directories found matching 'build' 02:32:08 INFO - no previously-included directories found matching 'dist' 02:32:08 INFO - no previously-included directories found matching '.git*' 02:32:08 INFO - Installing collected packages: jsonschema, functools32 02:32:08 INFO - Running setup.py install for functools32 02:32:08 INFO - warning: no files found matching '*.txt' 02:32:08 INFO - no previously-included directories found matching 'build' 02:32:08 INFO - no previously-included directories found matching 'dist' 02:32:08 INFO - no previously-included directories found matching '.git*' 02:32:08 INFO - Successfully installed jsonschema functools32 02:32:08 INFO - Cleaning up... 02:32:08 INFO - Return code: 0 02:32:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:32:08 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')]} 02:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:08 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')]} 02:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:08 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 0x7f243ff63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cef60>, '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 0x27cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d01d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', '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 02:32:08 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 02:32:08 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 02:32:08 INFO - Using env: {'DISPLAY': ':0', 02:32:08 INFO - 'HOME': '/home/cltbld', 02:32:08 INFO - 'LANG': 'en_US.UTF-8', 02:32:08 INFO - 'LANGUAGE': 'en_US:en', 02:32:08 INFO - 'LOGNAME': 'cltbld', 02:32:08 INFO - 'MAIL': '/var/mail/cltbld', 02:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:08 INFO - 'MOZ_NO_REMOTE': '1', 02:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:08 INFO - 'NO_EM_RESTART': '1', 02:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:08 INFO - 'PWD': '/builds/slave/test', 02:32:08 INFO - 'SHELL': '/bin/bash', 02:32:08 INFO - 'SHLVL': '1', 02:32:08 INFO - 'TERM': 'linux', 02:32:08 INFO - 'TMOUT': '86400', 02:32:08 INFO - 'USER': 'cltbld', 02:32:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', 02:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:08 INFO - '_': '/tools/buildbot/bin/python'} 02:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:32:09 INFO - Cleaning up... 02:32:09 INFO - Return code: 0 02:32:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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 0x7f243ff63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cef60>, '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 0x27cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d01d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', '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 02:32: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 02:32: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 02:32:09 INFO - Using env: {'DISPLAY': ':0', 02:32:09 INFO - 'HOME': '/home/cltbld', 02:32:09 INFO - 'LANG': 'en_US.UTF-8', 02:32:09 INFO - 'LANGUAGE': 'en_US:en', 02:32:09 INFO - 'LOGNAME': 'cltbld', 02:32:09 INFO - 'MAIL': '/var/mail/cltbld', 02:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:09 INFO - 'MOZ_NO_REMOTE': '1', 02:32:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:09 INFO - 'NO_EM_RESTART': '1', 02:32:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:09 INFO - 'PWD': '/builds/slave/test', 02:32:09 INFO - 'SHELL': '/bin/bash', 02:32:09 INFO - 'SHLVL': '1', 02:32:09 INFO - 'TERM': 'linux', 02:32:09 INFO - 'TMOUT': '86400', 02:32:09 INFO - 'USER': 'cltbld', 02:32:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', 02:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:09 INFO - '_': '/tools/buildbot/bin/python'} 02:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:09 INFO - Downloading/unpacking blobuploader==1.2.4 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32:12 INFO - Downloading blobuploader-1.2.4.tar.gz 02:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:32:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:32:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32:13 INFO - Downloading docopt-0.6.1.tar.gz 02:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:32:13 INFO - Installing collected packages: blobuploader, requests, docopt 02:32:13 INFO - Running setup.py install for blobuploader 02:32:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:32:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:32:13 INFO - Running setup.py install for requests 02:32:13 INFO - Running setup.py install for docopt 02:32:13 INFO - Successfully installed blobuploader requests docopt 02:32:13 INFO - Cleaning up... 02:32:13 INFO - Return code: 0 02:32:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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 0x7f243ff63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cef60>, '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 0x27cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d01d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', '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 02:32: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 02:32: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 02:32:13 INFO - Using env: {'DISPLAY': ':0', 02:32:13 INFO - 'HOME': '/home/cltbld', 02:32:13 INFO - 'LANG': 'en_US.UTF-8', 02:32:13 INFO - 'LANGUAGE': 'en_US:en', 02:32:13 INFO - 'LOGNAME': 'cltbld', 02:32:13 INFO - 'MAIL': '/var/mail/cltbld', 02:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:13 INFO - 'MOZ_NO_REMOTE': '1', 02:32:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:13 INFO - 'NO_EM_RESTART': '1', 02:32:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:13 INFO - 'PWD': '/builds/slave/test', 02:32:13 INFO - 'SHELL': '/bin/bash', 02:32:13 INFO - 'SHLVL': '1', 02:32:13 INFO - 'TERM': 'linux', 02:32:13 INFO - 'TMOUT': '86400', 02:32:13 INFO - 'USER': 'cltbld', 02:32:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', 02:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:13 INFO - '_': '/tools/buildbot/bin/python'} 02:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:13 INFO - Running setup.py (path:/tmp/pip-AtkHi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:14 INFO - Running setup.py (path:/tmp/pip-_M1XCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:14 INFO - Running setup.py (path:/tmp/pip-AJdwLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:14 INFO - Running setup.py (path:/tmp/pip-TQFH0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:14 INFO - Running setup.py (path:/tmp/pip-y8R8qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:14 INFO - Running setup.py (path:/tmp/pip-ZGykK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:14 INFO - Running setup.py (path:/tmp/pip-p6uv6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:14 INFO - Running setup.py (path:/tmp/pip-xlIHi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:14 INFO - Running setup.py (path:/tmp/pip-ZcuEUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:14 INFO - Running setup.py (path:/tmp/pip-0of_DR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:14 INFO - Running setup.py (path:/tmp/pip-0H4WUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:14 INFO - Running setup.py (path:/tmp/pip-HFgFiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:14 INFO - Running setup.py (path:/tmp/pip-_fIkQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:14 INFO - Running setup.py (path:/tmp/pip-gzDznD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:14 INFO - Running setup.py (path:/tmp/pip-WO_qaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:15 INFO - Running setup.py (path:/tmp/pip-HQA0Ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:15 INFO - Running setup.py (path:/tmp/pip-rkggL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:32:15 INFO - Running setup.py install for manifestparser 02:32:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:32:15 INFO - Running setup.py install for mozcrash 02:32:15 INFO - Running setup.py install for mozdebug 02:32:15 INFO - Running setup.py install for mozdevice 02:32:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:32:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:32:15 INFO - Running setup.py install for mozfile 02:32:15 INFO - Running setup.py install for mozhttpd 02:32:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:32:15 INFO - Running setup.py install for mozinfo 02:32:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:32:15 INFO - Running setup.py install for mozInstall 02:32:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:32:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:32:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:32:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:32:15 INFO - Running setup.py install for mozleak 02:32:16 INFO - Running setup.py install for mozlog 02:32:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:32:16 INFO - Running setup.py install for moznetwork 02:32:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:32:16 INFO - Running setup.py install for mozprocess 02:32:16 INFO - Running setup.py install for mozprofile 02:32:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:32:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:32:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:32:16 INFO - Running setup.py install for mozrunner 02:32:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:32:16 INFO - Running setup.py install for mozscreenshot 02:32:16 INFO - Running setup.py install for moztest 02:32:16 INFO - Running setup.py install for mozversion 02:32:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:32:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:32:16 INFO - Cleaning up... 02:32:16 INFO - Return code: 0 02:32:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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 0x7f243ff63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cef60>, '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 0x27cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d01d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', '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 02:32: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 02:32: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 02:32:16 INFO - Using env: {'DISPLAY': ':0', 02:32:16 INFO - 'HOME': '/home/cltbld', 02:32:16 INFO - 'LANG': 'en_US.UTF-8', 02:32:16 INFO - 'LANGUAGE': 'en_US:en', 02:32:16 INFO - 'LOGNAME': 'cltbld', 02:32:16 INFO - 'MAIL': '/var/mail/cltbld', 02:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:16 INFO - 'MOZ_NO_REMOTE': '1', 02:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:16 INFO - 'NO_EM_RESTART': '1', 02:32:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:16 INFO - 'PWD': '/builds/slave/test', 02:32:16 INFO - 'SHELL': '/bin/bash', 02:32:16 INFO - 'SHLVL': '1', 02:32:16 INFO - 'TERM': 'linux', 02:32:16 INFO - 'TMOUT': '86400', 02:32:16 INFO - 'USER': 'cltbld', 02:32:16 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', 02:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:16 INFO - '_': '/tools/buildbot/bin/python'} 02:32:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:17 INFO - Running setup.py (path:/tmp/pip-AYi7Jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:17 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)) 02:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:17 INFO - Running setup.py (path:/tmp/pip-ibpXWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:17 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)) 02:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:17 INFO - Running setup.py (path:/tmp/pip-521ci1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:17 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)) 02:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:17 INFO - Running setup.py (path:/tmp/pip-_W2imb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 02:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:17 INFO - Running setup.py (path:/tmp/pip-z10zdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32: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)) 02:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:17 INFO - Running setup.py (path:/tmp/pip-ntivxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32: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)) 02:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:17 INFO - Running setup.py (path:/tmp/pip-ijAp9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32: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)) 02:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:17 INFO - Running setup.py (path:/tmp/pip-AAc6O6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32: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)) 02:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:17 INFO - Running setup.py (path:/tmp/pip-MSVZln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32: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)) 02:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:17 INFO - Running setup.py (path:/tmp/pip-W3UjEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32: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)) 02:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:17 INFO - Running setup.py (path:/tmp/pip-ktgHG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:18 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)) 02:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:18 INFO - Running setup.py (path:/tmp/pip-wR4HNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:18 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)) 02:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:18 INFO - Running setup.py (path:/tmp/pip-gFPGed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:18 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)) 02:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:18 INFO - Running setup.py (path:/tmp/pip-yDx8Al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:18 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)) 02:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:18 INFO - Running setup.py (path:/tmp/pip-cnpMPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:18 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)) 02:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:18 INFO - Running setup.py (path:/tmp/pip-JwFjTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 02:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:18 INFO - Running setup.py (path:/tmp/pip-wNaBBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32: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)) 02:32: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)) 02:32: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)) 02:32: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)) 02:32: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:32: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:32:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32:20 INFO - Downloading blessings-1.6.tar.gz 02:32:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:32:20 INFO - Installing collected packages: blessings 02:32:20 INFO - Running setup.py install for blessings 02:32:20 INFO - Successfully installed blessings 02:32:20 INFO - Cleaning up... 02:32:20 INFO - Return code: 0 02:32:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:32:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:32:20 INFO - Reading from file tmpfile_stdout 02:32:20 INFO - Current package versions: 02:32:20 INFO - argparse == 1.2.1 02:32:20 INFO - blessings == 1.6 02:32:20 INFO - blobuploader == 1.2.4 02:32:20 INFO - docopt == 0.6.1 02:32:20 INFO - functools32 == 3.2.3-2 02:32:20 INFO - jsonschema == 2.5.1 02:32:20 INFO - manifestparser == 1.1 02:32:20 INFO - mozInstall == 1.12 02:32:20 INFO - mozcrash == 1.0 02:32:20 INFO - mozdebug == 0.1 02:32:20 INFO - mozdevice == 0.48 02:32:20 INFO - mozfile == 1.2 02:32:20 INFO - mozhttpd == 0.7 02:32:20 INFO - mozinfo == 0.9 02:32:20 INFO - mozleak == 0.1 02:32:20 INFO - mozlog == 3.4 02:32:20 INFO - moznetwork == 0.27 02:32:20 INFO - mozprocess == 0.23 02:32:20 INFO - mozprofile == 0.28 02:32:20 INFO - mozrunner == 6.13 02:32:20 INFO - mozscreenshot == 0.1 02:32:20 INFO - mozsystemmonitor == 0.3 02:32:20 INFO - moztest == 0.8 02:32:20 INFO - mozversion == 1.4 02:32:20 INFO - psutil == 3.1.1 02:32:20 INFO - requests == 1.2.3 02:32:20 INFO - wsgiref == 0.1.2 02:32:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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 0x7f243ff63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cef60>, '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 0x27cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d01d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', '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 02:32: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 02:32: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 02:32:20 INFO - Using env: {'DISPLAY': ':0', 02:32:20 INFO - 'HOME': '/home/cltbld', 02:32:20 INFO - 'LANG': 'en_US.UTF-8', 02:32:20 INFO - 'LANGUAGE': 'en_US:en', 02:32:20 INFO - 'LOGNAME': 'cltbld', 02:32:20 INFO - 'MAIL': '/var/mail/cltbld', 02:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:20 INFO - 'MOZ_NO_REMOTE': '1', 02:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:20 INFO - 'NO_EM_RESTART': '1', 02:32:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:20 INFO - 'PWD': '/builds/slave/test', 02:32:20 INFO - 'SHELL': '/bin/bash', 02:32:20 INFO - 'SHLVL': '1', 02:32:20 INFO - 'TERM': 'linux', 02:32:20 INFO - 'TMOUT': '86400', 02:32:20 INFO - 'USER': 'cltbld', 02:32:20 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', 02:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:20 INFO - '_': '/tools/buildbot/bin/python'} 02:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:21 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)) 02:32:21 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)) 02:32:21 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)) 02:32:21 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)) 02:32:21 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)) 02:32:21 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)) 02:32:21 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)) 02:32:21 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)) 02:32:21 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)) 02:32:21 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)) 02:32:21 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)) 02:32:21 INFO - Cleaning up... 02:32:21 INFO - Return code: 0 02:32:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:32:21 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')]} 02:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:21 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')]} 02:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:21 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 0x7f243ff63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cef60>, '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 0x27cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d01d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', '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 02:32:21 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 02:32:21 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 02:32:21 INFO - Using env: {'DISPLAY': ':0', 02:32:21 INFO - 'HOME': '/home/cltbld', 02:32:21 INFO - 'LANG': 'en_US.UTF-8', 02:32:21 INFO - 'LANGUAGE': 'en_US:en', 02:32:21 INFO - 'LOGNAME': 'cltbld', 02:32:21 INFO - 'MAIL': '/var/mail/cltbld', 02:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:21 INFO - 'MOZ_NO_REMOTE': '1', 02:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:21 INFO - 'NO_EM_RESTART': '1', 02:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:21 INFO - 'PWD': '/builds/slave/test', 02:32:21 INFO - 'SHELL': '/bin/bash', 02:32:21 INFO - 'SHLVL': '1', 02:32:21 INFO - 'TERM': 'linux', 02:32:21 INFO - 'TMOUT': '86400', 02:32:21 INFO - 'USER': 'cltbld', 02:32:21 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', 02:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:21 INFO - '_': '/tools/buildbot/bin/python'} 02:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:32:21 INFO - Cleaning up... 02:32:21 INFO - Return code: 0 02:32:21 INFO - Running post-action listener: _resource_record_post_action 02:32:21 INFO - Running post-action listener: _start_resource_monitoring 02:32:21 INFO - Starting resource monitoring. 02:32:21 INFO - [mozharness: 2017-01-11 10:32:21.434901Z] Finished create-virtualenv step (success) 02:32:21 INFO - [mozharness: 2017-01-11 10:32:21.435360Z] Running install step. 02:32:21 INFO - Running pre-action listener: _resource_record_pre_action 02:32:21 INFO - Running main action method: install 02:32:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:32:21 INFO - Reading from file tmpfile_stdout 02:32:21 INFO - Detecting whether we're running mozinstall >=1.0... 02:32:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:32:21 INFO - Reading from file tmpfile_stdout 02:32:21 INFO - Output received: 02:32:21 INFO - Usage: mozinstall [options] installer 02:32:21 INFO - Options: 02:32:21 INFO - -h, --help show this help message and exit 02:32:21 INFO - -d DEST, --destination=DEST 02:32:21 INFO - Directory to install application into. [default: 02:32:21 INFO - "/builds/slave/test"] 02:32:21 INFO - --app=APP Application being installed. [default: firefox] 02:32:21 INFO - mkdir: /builds/slave/test/build/application 02:32:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:32:37 INFO - Reading from file tmpfile_stdout 02:32:37 INFO - Output received: 02:32:37 INFO - /builds/slave/test/build/application/firefox/firefox 02:32:37 INFO - Running post-action listener: _resource_record_post_action 02:32:37 INFO - [mozharness: 2017-01-11 10:32:37.659093Z] Finished install step (success) 02:32:37 INFO - [mozharness: 2017-01-11 10:32:37.659336Z] Running run-tests step. 02:32:37 INFO - Running pre-action listener: _resource_record_pre_action 02:32:37 INFO - Running main action method: run_tests 02:32:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:32:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:32:37 INFO - Python 2.7.3 02:32:37 INFO - Return code: 0 02:32:37 INFO - grabbing minidump binary from tooltool 02:32:37 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')]} 02:32:37 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 0x27cef60>, '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 0x27cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d01d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:32:37 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 02:32:37 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 02:32:37 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 02:32:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:32:37 INFO - Return code: 0 02:32:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:32:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:32:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:32:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:32:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:32:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 02:32:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 02:32:37 INFO - Using env: {'DISPLAY': ':0', 02:32:37 INFO - 'HOME': '/home/cltbld', 02:32:37 INFO - 'LANG': 'en_US.UTF-8', 02:32:37 INFO - 'LANGUAGE': 'en_US:en', 02:32:37 INFO - 'LOGNAME': 'cltbld', 02:32:37 INFO - 'MAIL': '/var/mail/cltbld', 02:32:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:32:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:37 INFO - 'MOZ_NO_REMOTE': '1', 02:32:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:37 INFO - 'NO_EM_RESTART': '1', 02:32:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:37 INFO - 'PWD': '/builds/slave/test', 02:32:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:32:37 INFO - 'SHELL': '/bin/bash', 02:32:37 INFO - 'SHLVL': '1', 02:32:37 INFO - 'TERM': 'linux', 02:32:37 INFO - 'TMOUT': '86400', 02:32:37 INFO - 'USER': 'cltbld', 02:32:37 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787', 02:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:37 INFO - '_': '/tools/buildbot/bin/python'} 02:32:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 02:32:37 INFO - mozversion application_buildid: 20170111004018 02:32:37 INFO - mozversion application_changeset: 5cf9f0f65d201fc4631530c8f00e3a14887c1ad1 02:32:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:32:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:32:37 INFO - mozversion application_name: Firefox 02:32:37 INFO - mozversion application_remotingname: firefox-dev 02:32:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:32:37 INFO - mozversion application_vendor: Mozilla 02:32:37 INFO - mozversion application_version: 52.0a2 02:32:37 INFO - mozversion platform_buildid: 20170111004018 02:32:37 INFO - mozversion platform_changeset: 5cf9f0f65d201fc4631530c8f00e3a14887c1ad1 02:32:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:32:37 INFO - mozversion platform_version: 52.0a2 02:32:37 INFO - using testdate: 1484130757 02:32:37 INFO - actual date: 1484130757 02:32:37 INFO - starting webserver on 'localhost:33730' 02:32:37 INFO - SUITE-START | Running 2 tests 02:32:37 INFO - TEST-START | dromaeo_css 02:32:37 INFO - operating with platform_type : linux_ 02:32:37 INFO - Initialising browser for dromaeo_css test... 02:32:37 INFO - TEST-INFO | started process 27808 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWqQTI_/profile http://localhost:33730/getInfo.html) 02:32:42 INFO - PROCESS | 27808 | __metrics Screen width/height:1600/1200 02:32:42 INFO - PROCESS | 27808 | colorDepth:24 02:32:42 INFO - PROCESS | 27808 | Browser inner width/height: 1024/697 02:32:42 INFO - PROCESS | 27808 | __metrics 02:32:42 ERROR - PROCESS | 27808 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 02:32:43 INFO - TEST-INFO | 27808: exit 0 02:32:43 INFO - Browser initialized. 02:32:43 INFO - Running cycle 1/1 for dromaeo_css test... 02:32:43 INFO - TEST-INFO | started process 27941 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWqQTI_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:32:55 INFO - PROCESS | 27941 | RSS: Main: 151109632 02:32:55 INFO - PROCESS | 27941 | 02:35:55 INFO - PROCESS | 27941 | Cycle 1(1): loaded http://localhost:33730/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33730/tests/dromaeo/cssquery-ext.html) 02:35:56 INFO - PROCESS | 27941 | RSS: Main: 156667904 02:35:56 INFO - PROCESS | 27941 | 02:38:58 INFO - PROCESS | 27941 | Cycle 1(1): loaded http://localhost:33730/tests/dromaeo/cssquery-ext.html (next: http://localhost:33730/tests/dromaeo/cssquery-jquery.html) 02:38:59 INFO - PROCESS | 27941 | RSS: Main: 152793088 02:38:59 INFO - PROCESS | 27941 | 02:42:01 INFO - PROCESS | 27941 | Cycle 1(1): loaded http://localhost:33730/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33730/tests/dromaeo/cssquery-mootools.html) 02:42:01 INFO - PROCESS | 27941 | RSS: Main: 152674304 02:42:01 INFO - PROCESS | 27941 | 02:45:03 INFO - PROCESS | 27941 | Cycle 1(1): loaded http://localhost:33730/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33730/tests/dromaeo/cssquery-prototype.html) 02:45:04 INFO - PROCESS | 27941 | RSS: Main: 151973888 02:45:04 INFO - PROCESS | 27941 | 02:48:06 INFO - PROCESS | 27941 | Cycle 1(1): loaded http://localhost:33730/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33730/tests/dromaeo/cssquery-yui.html) 02:48:07 INFO - PROCESS | 27941 | RSS: Main: 154730496 02:48:07 INFO - PROCESS | 27941 | 02:51:09 INFO - PROCESS | 27941 | Cycle 1(1): loaded http://localhost:33730/tests/dromaeo/cssquery-yui.html (next: http://localhost:33730/tests/dromaeo/cssquery-dojo.html) 02:51:09 INFO - PROCESS | 27941 | RSS: Main: 155729920 02:51:09 INFO - PROCESS | 27941 | 02:51:09 INFO - PROCESS | 27941 | __start_tp_report 02:51:09 INFO - PROCESS | 27941 | _x_x_mozilla_page_load 02:51:09 INFO - PROCESS | 27941 | _x_x_mozilla_page_load_details 02:51:09 INFO - PROCESS | 27941 | |i|pagename|runs| 02:51:09 INFO - PROCESS | 27941 | |0;dojo.html;3262.983685081574;3312.5196846457247;3313.4532802087656;3327.3678001179787;3327.7005069543734;5688.402717714637;5743.195952566644;5758.280214973129;5768.278965129359;5790.884182316346;5772;5821.18503409523;5857.326407463143;5864.354920958691;5866.354700982888;5285.841424757245;5293.576513878899;5327.733613319338;5350.946490535103;5368.141097424413;5353.250544923714;5369.582332599202;5370.973145134269;5371.973140134294;5394.7842086316505;5138.229265610151;5147.1764517677175;5338.599605029638;5362.973185134068;5374.48942350476;5152.690838549699;5153.072446959564;5204.661696989683;5248.265242866002;5310.123829568117;5150.201718733602;5224.895502089937;5252.159654455307;5254.605904557136;5286.471352864722;5512.228288039678;5658.207850900877;5689.943100569024;5762.135679648086;5774.595778295521;5983.461488466015;5993.220881285405;6010.96994515029;6012.3085845127935;6022.488088512482;6017.338092809788;6036.3360030396625;6054.848628784272;6114.510839132859;6133.172021777093;5716.714164291769;5718.142278658234;5723.627964182315;5728.828135155952;5732.5127364174095;6119.929102025404;6132.78535251264;6133.640713961371;6208.81373558794;6216.658083805434;5956.702164891824;6010.579259451796;6019.187409699722;6021.066734656135;6021.307549631761;5954.55340849438;5974.133750606138;6117.449429551273;6119.44924956756;6127.479164271087;6059.1820104286235;6086;6101;6159.96920015406;6175.197224360804;6075.273636300304;6134.110553969649;6149.046897730859;6154.5384096192965;6164;4606.539346065367;4742.383490146259;4745.786439610157;4747.8100875965265;4749.073930583572;4143.585641435832;4157.48031496063;4174.749515029108;4214.515330736943;4238.173556156582;5896.439838215363;5935.465808077208;5937.970310148508;5953.017752070859;5957.076653118774;6120.17377654011;6150.907736383958;6170.660613666201;6178.0424034273865;6179.3820617937845;5874.060150375919;5894.587378883522;5932.851678707981;5952.0476723724;5995.190649262381;5322.893542129135;5347.491988261109;5361.705106219196;5369.27514785499;5374.1938709193155;6501.642409667514;6527.804165875032;6567.704453299709;6569.934300657028;6576.76981305652;5963.493103086286;6027.849303767441;6069.332373439007;6069.393060693896;6229.626222426669;6395.744170233324;6432.35676432353;6443.516736244706;6448.484121270193;6449.7420103195345;5968.6717230551;6051;6077.726502307495;6080.148779171008;6089.604175728564;5953.077273022688;5987.670678112746;6056.485198758155;6187.226596675416;6189.226346706661;5945.3757355477055;6013.548983826318;6036.245469316335;6060.181875446759;6062.636241825505;5959.433853783884;6011;6015.759369625341;6017.338092809699;6020.157177994996;5686.289213848269;5712.771489140554;5953.821385358447;5959.374265702038;5962.314333851663;5902;5909.734061967136;5920.141579471038;5970.164177015308;5984.16221728967;5760.510356619567;5825.242718446575;5830.708464576669;5843.444872737083;5852 02:51:09 INFO - PROCESS | 27941 | |1;ext.html;576.7865889620838;616.7502161624542;628.0861346740492;652.7454292825796;665.8102440804365;42391.78804105979;43222.135557288835;43260.134797304076;45940.081198376014;46365.7681711591;44758.552414475846;45001.77499112508;45164.0967180657;45254.77372613132;45371.09257814842;8762.561871906411;8862.60118294675;8863.335249856254;8916.420432671888;8916.465012099296;8758.211760941515;8803.95598022009;8843.115688431137;8876.245519130849;8884.777880553005;8878.422902511316;8942;8943.150400711922;8949.64201431942;8967.596458159398;8853.29173666105;8920.286377089817;8921.375503714742;8922.955385223033;8925.062868398822;8750.781230469225;8756.649734010633;8765;8786.64853405863;8813.515256660881;41731;42062;42096.78951605253;42131.7893410534;42227.36658950118;3256.299895522474;3695.4826324314618;3839.8080095995088;3876.186000939806;4096.016955930555;32343.191420214447;32561.51157732636;32724.6727532724;32772.508412373834;32958.3408331832;4491.663125265585;4558.794854231567;4565.543445655441;4587.380703605004;4600.3099535070005;346553.0689386223;348322;348329;348864;350063;60622;61023;61417;61427.692861535405;61527.6923615388;58899.41100588939;59061.70469147627;59284.7035764827;59484.70257648684;59692;14469.710605787825;14503.709925801424;14572.562823115324;14735;14789.482368117064;10980.505877235544;10992.670219893416;11016.228863979444;11023.228374013743;11101.944490277498;17320.39378621742;18304;18309.633807324044;18334;18349;6106.572539922252;6152.569320147636;6162.876742465126;6304.432601065834;6315.96842015787;951.3958636266021;996.461910568285;1014.5890914179769;1023.6007956896816;1118.6755840806075;30732.38535229283;31132.221694457367;31299.68700312968;31800.204994875312;32556.186095347806;1032.695354870315;1111.1721767283263;1119.160629527854;1145.9885401146048;1256.918300310477;16217.696014016814;16353.34586616522;16990;17653.911730441523;17723.29106835712;496350;511079;511965;514039;514909;60521;60549;60698.39301607016;60864;60900;1354.2483921423507;1363.9931800340935;1365.5834970333945;1380.4133243371527;1410.9647258818406;31095;32761.67238327586;33146.33707325888;33232;33375.81910060157;52905;53190;53222.4677753233;53312.2003169945;53552;418559;419379;421548;422789;422966;29539.113826585235;29739.55390669185;29866;30129.24676883008;30179.245518862204;47653.523464766295;47922.281165781846;48445.75777121092;48492.5150748488;48494.757526212146;39969;40059;40334;41236.175276494905;42103.57896421119;39435.2112957745;41148.1770364597;42123;42244.36633450439;42394.78802605967;40312.39531406973;40757.59242407538;40895.795521022206;41989.1602167961;43368;34984.47523287102;36478.63521364859;36826;36996.26007479889;37642;28542.85728571344;28887.133385998455;28983.710162898944;29072.41855162927;29287.560686590143 02:51:09 INFO - PROCESS | 27941 | |2;jquery.html;409.4554242857001;421.6984855828084;428.26967424374556;430.6059955141045;435.3448060668693;18443.26226950922;19040.7151141863;19995.900020499877;20326.288579899705;20606.866622335765;19151.42545723627;19285;19390.806091939077;19647;19685.311014114508;5724.656520608777;5900.498457631106;5928.318243402021;5962.612430192024;5972.761089556412;5653.575981801361;5736.139579063132;5872.412758724115;5949.226600541923;5960.731767070492;5861.912071318934;5863.061910094386;5902.291724992985;5906.497947674453;5907.527397808187;5580.414056524068;5770.711464426762;5814.651120932736;5818.767249310023;5899.793507227248;5199.194124910645;5202.869928251824;5205.505476979719;5206.114960456732;5207.895842083175;23120.190793322323;23209.419764505852;23860.284191474282;23922.880385598135;23996;2399.652050452692;2436.50051739393;2461.0770960889668;2585.2631999879945;2694.178275625933;14633.414663413558;15367.077975321405;15404.537863864101;15531.844681553153;15815.706722525169;1964.2535836382226;1975.3283883479685;2060.320094368855;2115.4288342147534;2126.723525941633;83209;84200.57899710462;85114.99999999937;85621.57189214077;86518;10710.410927398912;10807.243492955418;10885.346879187275;11223.60717374888;11373.886261137448;14199.432022719182;14215.644608884653;14244.715105697827;14263.215523146118;14347.92826035863;7676.078870535572;7685.884711729329;7834.255745704149;7859.096203936506;7903.68385264583;7171.1394632644415;7297;7309.232530584319;7452.590107544029;7452.776416707399;6538.640374779433;6694.899576506259;6778.22050464193;6807.557508762014;6873.896891546631;2000.6698894682215;2089.822365098953;2095.5599324141795;2096.6854971754055;2108.820750236247;919.3242966419676;1010.7877345757473;1049.2130901823632;1071.5767271927546;1088.7822435512928;20208.191672333236;20321.89839050795;20420.897895510723;20513.076911539018;20785.272515461886;1046.9110125639254;1059.427908929185;1071.244772435431;1106.1416819742908;1120.9743085077064;11027.2280940335;11650.184487085822;11690.941545292219;11706.297622142698;11758.764824703629;472803;473599;475520;478981;486695;80229.59885200537;83269.58365208257;84078.57960710158;84375;85870;1000.1348833259178;1041.8489319048695;1056.6829951014818;1065.872095348563;1074.897884700952;18121.456356309332;18649.254029838656;18673;18801.717974230673;18921.716174257122;40174;45758.313625296316;45897.08205835798;46014.309785352576;46109;63130.36869631245;63963.68018159879;64497.67751161214;64514;65388;7994.200579941959;8824.91175088241;8917;9268.165865072177;9272.350935434724;13013.154144980546;13687.589372318846;13766.174029558259;13798.724025519232;13847.238401887993;11964.880351196376;11965.521379144737;12104.878951210376;12200.206986545845;12390.442430090487;11552.82670759956;11596.130290228435;11751.353675547927;11939.223950443193;11991;12224.144309898578;12245.387730613611;12306.446209920396;12311.56909508163;12381.257124572194;8486.702965396182;8492.490450572985;8583.098774628825;8654.264387527131;8738.475691458532;10792.406417647106;11113.277636953571;11466.82799758021;11936.641900742992;12036.578719744766 02:51:09 INFO - PROCESS | 27941 | |3;mootools.html;1478.3643033495598;1478.9482368117115;1633.4854520825938;1754.754124571554;1795.9640807183864;8056.758297251077;8303;8472.279856212223;9149.725508234747;9171.770705732351;8540.316774658027;8805.471671699703;8820.162084601969;9050.32122590805;9102.13529714676;2426.817988650849;2479.404942813721;2496.0639760089966;2503.211488381154;2505.1983365323103;2443.816713746467;2554.4124851284214;2555.9616605750834;2556.4120252341972;2558.2453176313034;2470.22188010776;2471.209213051824;2471.468634243637;2485.639582260571;2494.3514686181634;2479.6156595727603;2486.8383555068863;2504.6743923290037;2510.7740303372602;2514.019532382354;2494.6756921600077;2494.825362224645;2495.089292408276;2514.861682607456;2521.2688320387065;9007.964084130343;9014.18872301496;9083.409578377385;9161.496117713523;9188.081191880825;5430.70131142787;5500.642458240201;5524.696141712204;5527.585431092644;5535.778568857241;3372.359251742161;3523.4186359250693;3545.3441113394106;3569.250457403948;3613.241219343941;1094.6606551968914;1133.3709791065955;1157.3634501024487;1157.6816375496805;1184.9644510664693;12584.874151258553;12714.809277860839;12717.936410317889;12739.04457165707;12769.808452873214;4707;4792.664513484023;4891.437484689306;4899.216125419915;4958.57852082577;10699.94650026745;10700.732481688021;10759.515821787882;10776.407297598551;10803.243772935975;5578.023845826964;5578.497935185853;5580.665160090326;5586.385497595261;5586.608937374344;4922.704637721748;4976.303317535548;5080.110980578458;5097.8215762448135;5111.875387414762;3773.113318370181;3824.7896365700153;3838.616138386139;3899.6880249579967;3914.2758589660434;1222.468226321553;1225.3444407242082;1230.9076819238594;1237.5111830826772;1248.3820508848178;833.4999000599713;979.2215188924822;982.1995074014656;1003.6988903328972;1009.7223263602568;6013.51891848651;6052.364501727343;6198.318184999646;6204.689765511706;6218.875622487525;446.73865788513433;1028.5422986770964;1029.0275689473376;1069.51871657753;1100.790849738563;3683.042408973686;3684.9447258291148;3726.9627303727157;3757.1358587524473;3757.1546402059867;10619.84070238947;10793.784124317626;10950.726231844268;10966.835497467544;10981.6156434526;10822.188335874684;10883.292585981886;10907.345559266469;10939.945300273448;10977.780444391068;8038.437309388403;8396.412251142483;8489.702860399857;8664.09027052163;8686.087960764155;5870.7945221917025;5874.911876321773;6038.215032045806;6128.938710612837;6244.375562443719;10294.691159265234;10299.742506437398;10420.374777513374;10453.320534165256;10476.528556214836;10383.584656613652;10509.527071281658;10529.368237905444;10547.525361358605;10597.205209609465;7518.398528117628;7727.034120734908;7779.299863012356;7894.605269736376;8115.75652730419;8688.956555217184;8713.259372953116;8720.825583488422;8738.956305218433;8746.781330466534;7694.538327700356;7699.769006929801;7858.371330293448;7911.327537159406;7933.206679332251;7700.768976930701;7725.072991241087;7738;7767.300942915164;7905.01187351581;7268.454865884974;7325.853482930205;7330.340269375782;7338.229485904117;7367;5279.788808447773;5346.25152478661;5382;5539;5606.719664016864;5109.335786347751;5162.122439185272;5184.403793563638;5198.16829307309;5232.633715639869 02:51:09 INFO - PROCESS | 27941 | |4;prototype.html;353.9557555305587;362.3459655322142;362.9473726309685;363.4874826494643;363.9745217834751;5622.4939755422;5642.3511296200895;5668.574856885734;5685.886282274352;5689.715514224283;5530.751116199771;5581.609287349887;5582.748776305066;5592.993261212991;5610.326760788701;4166.5833416658315;4230.957690423103;4332.350147477872;4346.152885023868;4367.978160109195;4315.525292217853;4326.8269269229195;4332.523422423531;4348.586884245991;4364.018095928423;4309.612134907858;4312.676549258803;4333.263345231302;4336.132773445308;4355.36847157162;4193.706440549147;4297.23991507431;4298.914021719579;4323.65410767141;4340.131973605276;3818.503594532693;3825;3832.2527107214105;3835.654791068789;3836.405357169643;5399.271098401744;5402.568319395364;5418.972905135449;5421.671690435829;5422.240886275925;4801.5438533339275;4919.72941488218;4968.925466118011;4975.328330675348;4987.226979818134;5777.62445441045;5810.651360918316;5818.825435236908;5828.821449263752;5847.707614619295;4186.958130418718;4190.371444283352;4210.663146948237;4215.473065866767;4225.809838557272;5797.608399086539;5855.619384739978;5963.970180149072;5994.13085102662;5996.4902983246475;4250.553691862372;4270.850520231839;4271.444712187395;4273.401723758676;4275.444192254987;4280.892977675583;4312.116016216668;4341.131773645284;4355.433793606874;4391.516933137353;4877.268409738496;4974;4978.701277923336;4986.152354099811;5003.524665156804;5815.331236907725;5846.6784326862435;5852.356240813507;5874.706264686749;5900.203472531153;1452.5111760445627;1457.846926072747;1464.648484363745;1470.154661069889;1476.6382236351947;983.7835676151235;1018.5162048027128;1018.8369860822381;1032.9586816527406;1033.5297439665085;5587.93829172464;5606.1590761385305;5637.633553818989;5643.661380317194;5661.716914154275;5879.617824841372;5891.641764194454;5930.525557955353;5933.703314834241;5958.076498142795;5389.407165211824;5530.391656917735;5540.556755459635;5554.556175171419;5627.887442251132;3028.545718142296;3059.7399221066457;3067.907962761121;3077.415291094685;3093.3503964167326;5870;6105.8168254952425;6130.203073600493;6133;6134.570580059353;5825.456254092669;5851.824445266564;5875.441833025856;5882.3529411764675;5888.671826207734;6046.425589568984;6058.153072798805;6059.242594675666;6105.9694701526205;6119.816405507842;5697.886042279214;5783.421657834351;5940;5991.520678345635;6025.8192254232445;5935.287765467999;5941.643501389931;5943.64338139713;5955.196048533393;5983.354577491051;6163.753449862134;6312.495000399865;6335.809925702236;6339.7954388666;6474.1907261592305;4314.482262128565;4347.217500849751;4363.105563359567;4365.4979677337515;4367.781610919505;5790.739416726173;6076;6102.237220347457;6119.938800612115;6153.661548614869;5868;5907.3797251288;5971.536973441534;5974.1934838796205;5979.103134529855;5789.971050144891;5918.852028699317;5929.822105336847;5936.584439089395;5966.403359663999;5657.4908258256955;5823.621464604787;5848;5873.559483038704;5912.320083190316;5923.614965027259;5953.642781433128;5955.808838232458;5959.73181206838;5979.252593425822;5644.745986430538;5726.284214473191;5780.976658169607;5808.477237048686;5822.70886455667 02:51:09 INFO - PROCESS | 27941 | |5;yui.html;697.4211404534237;703.9120109986255;732.77284041947;748.7341993592278;817.918208179182;13783.173009619404;13960.860391396096;13987.510437134702;13990.580282591525;14779.334929928153;14462.204578748164;14631.707365852677;14757;15013;15018.474353397633;817.7138001699402;830.4933990265963;832.6627715775121;833.6540335760652;833.8374017066675;803.602216902634;825.145973916996;832.546262287055;837.4640230252643;838.3125836813815;875.1467319363601;875.5228400521731;877.5787621941472;877.8858748362704;878.3280790195473;870.1776820904248;871.7907702151501;873.2708188662411;874.3617159473556;874.7157173918438;636.859890824018;641.720851429625;644.8968165093562;646.001927022751;646.0857886091176;15077.396904123932;15402;15452.459163929321;15477.148756818371;15481.458148964732;14189.290535473185;14940.701185976219;15025.323860426308;15076.170810605412;15112.773308400383;11496.137789665809;11583.594574189947;11625.883741162565;11792.882071179265;11945.581904633384;3711.406175012012;3752.887413377603;3764.7176461765202;3795.7532760370764;3832.1952389998132;66632.3336766631;67502;67503.66248168728;68185.31814681839;68362.3163768361;9886.357386769838;10299.227557933185;10728.839067413996;10993.285436446606;11359.20485566019;20475.692864607045;20548.07533660959;20550.07524661394;20713.96430178485;20845;8102.675892964333;8139.95930020358;8221.095679475253;8250.628721707537;8545.700900468579;4573.634109271316;4624.491305956342;4653.2554791233915;4680.648951328664;4696.272077827942;3410.48842673596;3504.7021003214504;3507.877224297137;3516.1385460561814;3538.610752817188;610.4627927423838;627.8807026664919;631.4443289904855;637.3180696654628;649.3084864619166;619.3032838057186;674.4031532094034;675.3381685947799;678.9456843452512;720.1070672366228;8515.701950431829;8760.167784060504;8958.68644597449;9090.636374544943;9208.217301529312;502.0962267917806;606.3814908793095;614.2536817766346;634.346622978333;716.0905649824798;4217.536071032184;4269.850555230552;4293.849715259951;4316.201502722007;4483.267203321187;91352.54323728471;91774.54112729528;94211.52894235485;95578;98228;82079.58960205161;82885;83114.58442707748;84421.57789211014;87027.56486217654;75128.62435687786;75292.62353688196;75389.6230518844;77191;78644.60677696575;7885;8070.435069545076;8437.535935523605;8471.491710497143;8511.36164787631;48156.27765583449;48848;48848.75575622099;49043.50956490532;49210.75394623004;64155;65989;69281.65359173373;69638.65180674064;72131.27868721246;10750.516226769658;10968.17738669587;11303.152263580429;11605.30368177912;11864.169508134348;13470.52853150135;13493.32533373347;13510.459581616626;13530.255835929118;13532.86467135316;11961;12064.51741930348;12172.878271217174;12444.128910976146;12600.243985360541;12341.691457713629;12396.504139834306;12521.812172817597;12573.497060117494;12703.555375561811;10651.147908167482;11489.655310340702;11649.953148985967;11701.414929253673;12002.879971200176;10832.891671083189;11214.048258443205;11372.829407558727;11549.281723862796;11702.765944681229;10456.058954694114;10560.260781745204;10576.524056417325;10717.571297148026;10796.298240614335 02:51:09 INFO - PROCESS | 27941 | __end_tp_report 02:51:09 INFO - PROCESS | 27941 | __start_cc_report 02:51:09 INFO - PROCESS | 27941 | _x_x_mozilla_cycle_collect,323 02:51:09 INFO - PROCESS | 27941 | __end_cc_report 02:51:09 INFO - PROCESS | 27941 | __startTimestamp1484131869729__endTimestamp 02:51:09 INFO - PROCESS | 27941 | 02:51:09 INFO - PROCESS | 27941 | ------- Summary: start ------- 02:51:09 INFO - PROCESS | 27941 | Number of tests: 6 02:51:09 INFO - PROCESS | 27941 | 02:51:09 INFO - PROCESS | 27941 | [#0] dojo.html Cycles:165 Average:5708.48 Median:5952.05 stddev:639.06 (10.7%) stddev-sans-first:611.54 02:51:09 INFO - PROCESS | 27941 | Values: 3263.0 3312.5 3313.5 3327.4 3327.7 5688.4 5743.2 5758.3 5768.3 5790.9 5772.0 5821.2 5857.3 5864.4 5866.4 5285.8 5293.6 5327.7 5350.9 5368.1 5353.3 5369.6 5371.0 5372.0 5394.8 5138.2 5147.2 5338.6 5363.0 5374.5 5152.7 5153.1 5204.7 5248.3 5310.1 5150.2 5224.9 5252.2 5254.6 5286.5 5512.2 5658.2 5689.9 5762.1 5774.6 5983.5 5993.2 6011.0 6012.3 6022.5 6017.3 6036.3 6054.8 6114.5 6133.2 5716.7 5718.1 5723.6 5728.8 5732.5 6119.9 6132.8 6133.6 6208.8 6216.7 5956.7 6010.6 6019.2 6021.1 6021.3 5954.6 5974.1 6117.4 6119.4 6127.5 6059.2 6086.0 6101.0 6160.0 6175.2 6075.3 6134.1 6149.0 6154.5 6164.0 4606.5 4742.4 4745.8 4747.8 4749.1 4143.6 4157.5 4174.7 4214.5 4238.2 5896.4 5935.5 5938.0 5953.0 5957.1 6120.2 6150.9 6170.7 6178.0 6179.4 5874.1 5894.6 5932.9 5952.0 5995.2 5322.9 5347.5 5361.7 5369.3 5374.2 6501.6 6527.8 6567.7 6569.9 6576.8 5963.5 6027.8 6069.3 6069.4 6229.6 6395.7 6432.4 6443.5 6448.5 6449.7 5968.7 6051.0 6077.7 6080.1 6089.6 5953.1 5987.7 6056.5 6187.2 6189.2 5945.4 6013.5 6036.2 6060.2 6062.6 5959.4 6011.0 6015.8 6017.3 6020.2 5686.3 5712.8 5953.8 5959.4 5962.3 5902.0 5909.7 5920.1 5970.2 5984.2 5760.5 5825.2 5830.7 5843.4 5852.0 02:51:09 INFO - PROCESS | 27941 | 02:51:09 INFO - PROCESS | 27941 | [#1] ext.html Cycles:180 Average:59247.74 Median:231839.89 stddev:114179.03 (49.2%) stddev-sans-first:114414.36 02:51:09 INFO - PROCESS | 27941 | Values: 576.8 616.8 628.1 652.7 665.8 42391.8 43222.1 43260.1 45940.1 46365.8 44758.6 45001.8 45164.1 45254.8 45371.1 8762.6 8862.6 8863.3 8916.4 8916.5 8758.2 8804.0 8843.1 8876.2 8884.8 8878.4 8942.0 8943.2 8949.6 8967.6 8853.3 8920.3 8921.4 8923.0 8925.1 8750.8 8756.6 8765.0 8786.6 8813.5 41731.0 42062.0 42096.8 42131.8 42227.4 3256.3 3695.5 3839.8 3876.2 4096.0 32343.2 32561.5 32724.7 32772.5 32958.3 4491.7 4558.8 4565.5 4587.4 4600.3 346553.1 348322.0 348329.0 348864.0 350063.0 60622.0 61023.0 61417.0 61427.7 61527.7 58899.4 59061.7 59284.7 59484.7 59692.0 14469.7 14503.7 14572.6 14735.0 14789.5 10980.5 10992.7 11016.2 11023.2 11101.9 17320.4 18304.0 18309.6 18334.0 18349.0 6106.6 6152.6 6162.9 6304.4 6316.0 951.4 996.5 1014.6 1023.6 1118.7 30732.4 31132.2 31299.7 31800.2 32556.2 1032.7 1111.2 1119.2 1146.0 1256.9 16217.7 16353.3 16990.0 17653.9 17723.3 496350.0 511079.0 511965.0 514039.0 514909.0 60521.0 60549.0 60698.4 60864.0 60900.0 1354.2 1364.0 1365.6 1380.4 1411.0 31095.0 32761.7 33146.3 33232.0 33375.8 52905.0 53190.0 53222.5 53312.2 53552.0 418559.0 419379.0 421548.0 422789.0 422966.0 29539.1 29739.6 29866.0 30129.2 30179.2 47653.5 47922.3 48445.8 48492.5 48494.8 39969.0 40059.0 40334.0 41236.2 42103.6 39435.2 41148.2 42123.0 42244.4 42394.8 40312.4 40757.6 40895.8 41989.2 43368.0 34984.5 36478.6 36826.0 36996.3 37642.0 28542.9 28887.1 28983.7 29072.4 29287.6 02:51:09 INFO - PROCESS | 27941 | 02:51:09 INFO - PROCESS | 27941 | [#2] jquery.html Cycles:180 Average:29125.36 Median:23534.85 stddev:78728.05 (334.5%) stddev-sans-first:78919.38 02:51:09 INFO - PROCESS | 27941 | Values: 409.5 421.7 428.3 430.6 435.3 18443.3 19040.7 19995.9 20326.3 20606.9 19151.4 19285.0 19390.8 19647.0 19685.3 5724.7 5900.5 5928.3 5962.6 5972.8 5653.6 5736.1 5872.4 5949.2 5960.7 5861.9 5863.1 5902.3 5906.5 5907.5 5580.4 5770.7 5814.7 5818.8 5899.8 5199.2 5202.9 5205.5 5206.1 5207.9 23120.2 23209.4 23860.3 23922.9 23996.0 2399.7 2436.5 2461.1 2585.3 2694.2 14633.4 15367.1 15404.5 15531.8 15815.7 1964.3 1975.3 2060.3 2115.4 2126.7 83209.0 84200.6 85115.0 85621.6 86518.0 10710.4 10807.2 10885.3 11223.6 11373.9 14199.4 14215.6 14244.7 14263.2 14347.9 7676.1 7685.9 7834.3 7859.1 7903.7 7171.1 7297.0 7309.2 7452.6 7452.8 6538.6 6694.9 6778.2 6807.6 6873.9 2000.7 2089.8 2095.6 2096.7 2108.8 919.3 1010.8 1049.2 1071.6 1088.8 20208.2 20321.9 20420.9 20513.1 20785.3 1046.9 1059.4 1071.2 1106.1 1121.0 11027.2 11650.2 11690.9 11706.3 11758.8 472803.0 473599.0 475520.0 478981.0 486695.0 80229.6 83269.6 84078.6 84375.0 85870.0 1000.1 1041.8 1056.7 1065.9 1074.9 18121.5 18649.3 18673.0 18801.7 18921.7 40174.0 45758.3 45897.1 46014.3 46109.0 63130.4 63963.7 64497.7 64514.0 65388.0 7994.2 8824.9 8917.0 9268.2 9272.4 13013.2 13687.6 13766.2 13798.7 13847.2 11964.9 11965.5 12104.9 12200.2 12390.4 11552.8 11596.1 11751.4 11939.2 11991.0 12224.1 12245.4 12306.4 12311.6 12381.3 8486.7 8492.5 8583.1 8654.3 8738.5 10792.4 11113.3 11466.8 11936.6 12036.6 02:51:09 INFO - PROCESS | 27941 | 02:51:09 INFO - PROCESS | 27941 | [#3] mootools.html Cycles:180 Average:5940.40 Median:2180.51 stddev:3351.76 (153.7%) stddev-sans-first:3344.39 02:51:09 INFO - PROCESS | 27941 | Values: 1478.4 1478.9 1633.5 1754.8 1796.0 8056.8 8303.0 8472.3 9149.7 9171.8 8540.3 8805.5 8820.2 9050.3 9102.1 2426.8 2479.4 2496.1 2503.2 2505.2 2443.8 2554.4 2556.0 2556.4 2558.2 2470.2 2471.2 2471.5 2485.6 2494.4 2479.6 2486.8 2504.7 2510.8 2514.0 2494.7 2494.8 2495.1 2514.9 2521.3 9008.0 9014.2 9083.4 9161.5 9188.1 5430.7 5500.6 5524.7 5527.6 5535.8 3372.4 3523.4 3545.3 3569.3 3613.2 1094.7 1133.4 1157.4 1157.7 1185.0 12584.9 12714.8 12717.9 12739.0 12769.8 4707.0 4792.7 4891.4 4899.2 4958.6 10699.9 10700.7 10759.5 10776.4 10803.2 5578.0 5578.5 5580.7 5586.4 5586.6 4922.7 4976.3 5080.1 5097.8 5111.9 3773.1 3824.8 3838.6 3899.7 3914.3 1222.5 1225.3 1230.9 1237.5 1248.4 833.5 979.2 982.2 1003.7 1009.7 6013.5 6052.4 6198.3 6204.7 6218.9 446.7 1028.5 1029.0 1069.5 1100.8 3683.0 3684.9 3727.0 3757.1 3757.2 10619.8 10793.8 10950.7 10966.8 10981.6 10822.2 10883.3 10907.3 10939.9 10977.8 8038.4 8396.4 8489.7 8664.1 8686.1 5870.8 5874.9 6038.2 6128.9 6244.4 10294.7 10299.7 10420.4 10453.3 10476.5 10383.6 10509.5 10529.4 10547.5 10597.2 7518.4 7727.0 7779.3 7894.6 8115.8 8689.0 8713.3 8720.8 8739.0 8746.8 7694.5 7699.8 7858.4 7911.3 7933.2 7700.8 7725.1 7738.0 7767.3 7905.0 7268.5 7325.9 7330.3 7338.2 7367.0 5279.8 5346.3 5382.0 5539.0 5606.7 5109.3 5162.1 5184.4 5198.2 5232.6 02:51:09 INFO - PROCESS | 27941 | 02:51:09 INFO - PROCESS | 27941 | [#4] prototype.html Cycles:180 Average:4916.10 Median:5625.19 stddev:1447.15 (25.7%) stddev-sans-first:1410.12 02:51:09 INFO - PROCESS | 27941 | Values: 354.0 362.3 362.9 363.5 364.0 5622.5 5642.4 5668.6 5685.9 5689.7 5530.8 5581.6 5582.7 5593.0 5610.3 4166.6 4231.0 4332.4 4346.2 4368.0 4315.5 4326.8 4332.5 4348.6 4364.0 4309.6 4312.7 4333.3 4336.1 4355.4 4193.7 4297.2 4298.9 4323.7 4340.1 3818.5 3825.0 3832.3 3835.7 3836.4 5399.3 5402.6 5419.0 5421.7 5422.2 4801.5 4919.7 4968.9 4975.3 4987.2 5777.6 5810.7 5818.8 5828.8 5847.7 4187.0 4190.4 4210.7 4215.5 4225.8 5797.6 5855.6 5964.0 5994.1 5996.5 4250.6 4270.9 4271.4 4273.4 4275.4 4280.9 4312.1 4341.1 4355.4 4391.5 4877.3 4974.0 4978.7 4986.2 5003.5 5815.3 5846.7 5852.4 5874.7 5900.2 1452.5 1457.8 1464.6 1470.2 1476.6 983.8 1018.5 1018.8 1033.0 1033.5 5587.9 5606.2 5637.6 5643.7 5661.7 5879.6 5891.6 5930.5 5933.7 5958.1 5389.4 5530.4 5540.6 5554.6 5627.9 3028.5 3059.7 3067.9 3077.4 3093.4 5870.0 6105.8 6130.2 6133.0 6134.6 5825.5 5851.8 5875.4 5882.4 5888.7 6046.4 6058.2 6059.2 6106.0 6119.8 5697.9 5783.4 5940.0 5991.5 6025.8 5935.3 5941.6 5943.6 5955.2 5983.4 6163.8 6312.5 6335.8 6339.8 6474.2 4314.5 4347.2 4363.1 4365.5 4367.8 5790.7 6076.0 6102.2 6119.9 6153.7 5868.0 5907.4 5971.5 5974.2 5979.1 5790.0 5918.9 5929.8 5936.6 5966.4 5657.5 5823.6 5848.0 5873.6 5912.3 5923.6 5953.6 5955.8 5959.7 5979.3 5644.7 5726.3 5781.0 5808.5 5822.7 02:51:09 INFO - PROCESS | 27941 | 02:51:09 INFO - PROCESS | 27941 | [#5] yui.html Cycles:180 Average:18684.52 Median:48848.38 stddev:25697.80 (52.6%) stddev-sans-first:25734.39 02:51:09 INFO - PROCESS | 27941 | Values: 697.4 703.9 732.8 748.7 817.9 13783.2 13960.9 13987.5 13990.6 14779.3 14462.2 14631.7 14757.0 15013.0 15018.5 817.7 830.5 832.7 833.7 833.8 803.6 825.1 832.5 837.5 838.3 875.1 875.5 877.6 877.9 878.3 870.2 871.8 873.3 874.4 874.7 636.9 641.7 644.9 646.0 646.1 15077.4 15402.0 15452.5 15477.1 15481.5 14189.3 14940.7 15025.3 15076.2 15112.8 11496.1 11583.6 11625.9 11792.9 11945.6 3711.4 3752.9 3764.7 3795.8 3832.2 66632.3 67502.0 67503.7 68185.3 68362.3 9886.4 10299.2 10728.8 10993.3 11359.2 20475.7 20548.1 20550.1 20714.0 20845.0 8102.7 8140.0 8221.1 8250.6 8545.7 4573.6 4624.5 4653.3 4680.6 4696.3 3410.5 3504.7 3507.9 3516.1 3538.6 610.5 627.9 631.4 637.3 649.3 619.3 674.4 675.3 678.9 720.1 8515.7 8760.2 8958.7 9090.6 9208.2 502.1 606.4 614.3 634.3 716.1 4217.5 4269.9 4293.8 4316.2 4483.3 91352.5 91774.5 94211.5 95578.0 98228.0 82079.6 82885.0 83114.6 84421.6 87027.6 75128.6 75292.6 75389.6 77191.0 78644.6 7885.0 8070.4 8437.5 8471.5 8511.4 48156.3 48848.0 48848.8 49043.5 49210.8 64155.0 65989.0 69281.7 69638.7 72131.3 10750.5 10968.2 11303.2 11605.3 11864.2 13470.5 13493.3 13510.5 13530.3 13532.9 11961.0 12064.5 12172.9 12444.1 12600.2 12341.7 12396.5 12521.8 12573.5 12703.6 10651.1 11489.7 11650.0 11701.4 12002.9 10832.9 11214.0 11372.8 11549.3 11702.8 10456.1 10560.3 10576.5 10717.6 10796.3 02:51:09 INFO - PROCESS | 27941 | -------- Summary: end -------- 02:51:09 INFO - PROCESS | 27941 | 02:51:10 INFO - TEST-INFO | 27941: exit 0 02:51:10 INFO - TEST-OK | dromaeo_css | took 1112592ms 02:51:10 INFO - TEST-START | kraken 02:51:10 INFO - operating with platform_type : linux_ 02:51:10 INFO - Initialising browser for kraken test... 02:51:10 INFO - TEST-INFO | started process 28323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1XNXkK/profile http://localhost:33730/getInfo.html) 02:51:14 INFO - PROCESS | 28323 | __metrics Screen width/height:1600/1200 02:51:14 INFO - PROCESS | 28323 | colorDepth:24 02:51:14 INFO - PROCESS | 28323 | Browser inner width/height: 1024/697 02:51:14 INFO - PROCESS | 28323 | __metrics 02:51:15 ERROR - PROCESS | 28323 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 02:51:15 INFO - TEST-INFO | 28323: exit 0 02:51:15 INFO - Browser initialized. 02:51:15 INFO - Running cycle 1/1 for kraken test... 02:51:15 INFO - TEST-INFO | started process 28454 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1XNXkK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:51:27 INFO - PROCESS | 28454 | RSS: Main: 151519232 02:51:27 INFO - PROCESS | 28454 | 02:51:30 INFO - PROCESS | 28454 | Cycle 1(1): loaded http://localhost:33730/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33730/tests/kraken/driver.html?testName=audio-beat-detection) 02:51:31 INFO - PROCESS | 28454 | RSS: Main: 156504064 02:51:31 INFO - PROCESS | 28454 | 02:51:33 INFO - PROCESS | 28454 | Cycle 1(1): loaded http://localhost:33730/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33730/tests/kraken/driver.html?testName=audio-dft) 02:51:34 INFO - PROCESS | 28454 | RSS: Main: 155774976 02:51:34 INFO - PROCESS | 28454 | 02:51:37 INFO - PROCESS | 28454 | Cycle 1(1): loaded http://localhost:33730/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33730/tests/kraken/driver.html?testName=audio-fft) 02:51:37 INFO - PROCESS | 28454 | RSS: Main: 156147712 02:51:37 INFO - PROCESS | 28454 | 02:51:40 INFO - PROCESS | 28454 | Cycle 1(1): loaded http://localhost:33730/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33730/tests/kraken/driver.html?testName=audio-oscillator) 02:51:40 INFO - PROCESS | 28454 | RSS: Main: 155426816 02:51:40 INFO - PROCESS | 28454 | 02:51:42 INFO - PROCESS | 28454 | Cycle 1(1): loaded http://localhost:33730/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33730/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:51:43 INFO - PROCESS | 28454 | RSS: Main: 155443200 02:51:43 INFO - PROCESS | 28454 | 02:51:46 INFO - PROCESS | 28454 | Cycle 1(1): loaded http://localhost:33730/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33730/tests/kraken/driver.html?testName=imaging-darkroom) 02:51:47 INFO - PROCESS | 28454 | RSS: Main: 158457856 02:51:47 INFO - PROCESS | 28454 | 02:51:50 INFO - PROCESS | 28454 | Cycle 1(1): loaded http://localhost:33730/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33730/tests/kraken/driver.html?testName=imaging-desaturate) 02:51:51 INFO - PROCESS | 28454 | RSS: Main: 158138368 02:51:51 INFO - PROCESS | 28454 | 02:51:53 INFO - PROCESS | 28454 | Cycle 1(1): loaded http://localhost:33730/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33730/tests/kraken/driver.html?testName=json-parse-financial) 02:51:54 INFO - PROCESS | 28454 | RSS: Main: 158728192 02:51:54 INFO - PROCESS | 28454 | 02:51:55 INFO - PROCESS | 28454 | Cycle 1(1): loaded http://localhost:33730/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33730/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:51:56 INFO - PROCESS | 28454 | RSS: Main: 158019584 02:51:56 INFO - PROCESS | 28454 | 02:51:58 INFO - PROCESS | 28454 | Cycle 1(1): loaded http://localhost:33730/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33730/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:51:58 INFO - PROCESS | 28454 | RSS: Main: 157466624 02:51:58 INFO - PROCESS | 28454 | 02:52:00 INFO - PROCESS | 28454 | Cycle 1(1): loaded http://localhost:33730/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33730/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:52:01 INFO - PROCESS | 28454 | RSS: Main: 157913088 02:52:01 INFO - PROCESS | 28454 | 02:52:04 INFO - PROCESS | 28454 | Cycle 1(1): loaded http://localhost:33730/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33730/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:52:04 INFO - PROCESS | 28454 | RSS: Main: 157454336 02:52:04 INFO - PROCESS | 28454 | 02:52:07 INFO - PROCESS | 28454 | Cycle 1(1): loaded http://localhost:33730/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33730/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:52:08 INFO - PROCESS | 28454 | RSS: Main: 158109696 02:52:08 INFO - PROCESS | 28454 | 02:52:09 INFO - PROCESS | 28454 | Cycle 1(1): loaded http://localhost:33730/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33730/tests/kraken/driver.html?testName=ai-astar) 02:52:09 INFO - PROCESS | 28454 | RSS: Main: 159453184 02:52:09 INFO - PROCESS | 28454 | 02:52:09 INFO - PROCESS | 28454 | __start_tp_report 02:52:09 INFO - PROCESS | 28454 | _x_x_mozilla_page_load 02:52:09 INFO - PROCESS | 28454 | _x_x_mozilla_page_load_details 02:52:09 INFO - PROCESS | 28454 | |i|pagename|runs| 02:52:09 INFO - PROCESS | 28454 | |0;ai-astar;103;115;113;113;114;113;114;113;115;112 02:52:09 INFO - PROCESS | 28454 | |1;audio-beat-detection;145;126;123;165;121;126;123;122;152;122 02:52:09 INFO - PROCESS | 28454 | |2;audio-dft;162;162;163;165;163;161;164;162;162;164 02:52:09 INFO - PROCESS | 28454 | |3;audio-fft;75;76;75;113;76;76;76;75;109;77 02:52:09 INFO - PROCESS | 28454 | |4;audio-oscillator;82;82;111;84;83;81;96;82;81;115 02:52:09 INFO - PROCESS | 28454 | |5;imaging-gaussian-blur;118;123;118;117;117;118;117;118;118;124 02:52:09 INFO - PROCESS | 28454 | |6;imaging-darkroom;147;147;148;147;148;149;148;148;147;146 02:52:09 INFO - PROCESS | 28454 | |7;imaging-desaturate;84;85;85;85;85;85;85;85;86;85 02:52:09 INFO - PROCESS | 28454 | |8;json-parse-financial;53;52;54;53;57;54;55;53;53;54 02:52:09 INFO - PROCESS | 28454 | |9;json-stringify-tinderbox;62;60;59;59;60;59;61;59;61;59 02:52:09 INFO - PROCESS | 28454 | |10;stanford-crypto-aes;80;74;77;76;75;80;74;75;74;80 02:52:09 INFO - PROCESS | 28454 | |11;stanford-crypto-ccm;131;122;133;122;122;134;121;122;159;134 02:52:09 INFO - PROCESS | 28454 | |12;stanford-crypto-pbkdf2;150;152;154;151;159;154;154;156;154;156 02:52:09 INFO - PROCESS | 28454 | |13;stanford-crypto-sha256-iterative;70;68;63;64;62;62;62;65;60;73 02:52:09 INFO - PROCESS | 28454 | __end_tp_report 02:52:09 INFO - PROCESS | 28454 | __start_cc_report 02:52:09 INFO - PROCESS | 28454 | _x_x_mozilla_cycle_collect,812 02:52:09 INFO - PROCESS | 28454 | __end_cc_report 02:52:09 INFO - PROCESS | 28454 | __startTimestamp1484131929981__endTimestamp 02:52:09 INFO - PROCESS | 28454 | 02:52:09 INFO - PROCESS | 28454 | ------- Summary: start ------- 02:52:09 INFO - PROCESS | 28454 | Number of tests: 14 02:52:09 INFO - PROCESS | 28454 | 02:52:09 INFO - PROCESS | 28454 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.50 stddev:3.47 (3.1%) stddev-sans-first:1.01 02:52:09 INFO - PROCESS | 28454 | Values: 103.0 115.0 113.0 113.0 114.0 113.0 114.0 113.0 115.0 112.0 02:52:09 INFO - PROCESS | 28454 | 02:52:09 INFO - PROCESS | 28454 | [#1] audio-beat-detection Cycles:10 Average:132.50 Median:126.00 stddev:15.67 (12.4%) stddev-sans-first:15.96 02:52:09 INFO - PROCESS | 28454 | Values: 145.0 126.0 123.0 165.0 121.0 126.0 123.0 122.0 152.0 122.0 02:52:09 INFO - PROCESS | 28454 | 02:52:09 INFO - PROCESS | 28454 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 02:52:09 INFO - PROCESS | 28454 | Values: 162.0 162.0 163.0 165.0 163.0 161.0 164.0 162.0 162.0 164.0 02:52:09 INFO - PROCESS | 28454 | 02:52:09 INFO - PROCESS | 28454 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:14.91 (19.6%) stddev-sans-first:15.54 02:52:09 INFO - PROCESS | 28454 | Values: 75.0 76.0 75.0 113.0 76.0 76.0 76.0 75.0 109.0 77.0 02:52:09 INFO - PROCESS | 28454 | 02:52:09 INFO - PROCESS | 28454 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:82.00 stddev:13.08 (16.0%) stddev-sans-first:13.57 02:52:09 INFO - PROCESS | 28454 | Values: 82.0 82.0 111.0 84.0 83.0 81.0 96.0 82.0 81.0 115.0 02:52:10 INFO - PROCESS | 28454 | 02:52:10 INFO - PROCESS | 28454 | [#5] imaging-gaussian-blur Cycles:10 Average:118.80 Median:118.00 stddev:2.53 (2.1%) stddev-sans-first:2.67 02:52:10 INFO - PROCESS | 28454 | Values: 118.0 123.0 118.0 117.0 117.0 118.0 117.0 118.0 118.0 124.0 02:52:10 INFO - PROCESS | 28454 | 02:52:10 INFO - PROCESS | 28454 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 02:52:10 INFO - PROCESS | 28454 | Values: 147.0 147.0 148.0 147.0 148.0 149.0 148.0 148.0 147.0 146.0 02:52:10 INFO - PROCESS | 28454 | 02:52:10 INFO - PROCESS | 28454 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.47 (0.6%) stddev-sans-first:0.33 02:52:10 INFO - PROCESS | 28454 | Values: 84.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 86.0 85.0 02:52:10 INFO - PROCESS | 28454 | 02:52:10 INFO - PROCESS | 28454 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.40 (2.6%) stddev-sans-first:1.45 02:52:10 INFO - PROCESS | 28454 | Values: 53.0 52.0 54.0 53.0 57.0 54.0 55.0 53.0 53.0 54.0 02:52:10 INFO - PROCESS | 28454 | 02:52:10 INFO - PROCESS | 28454 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:1.10 (1.8%) stddev-sans-first:0.87 02:52:10 INFO - PROCESS | 28454 | Values: 62.0 60.0 59.0 59.0 60.0 59.0 61.0 59.0 61.0 59.0 02:52:10 INFO - PROCESS | 28454 | 02:52:10 INFO - PROCESS | 28454 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:76.50 stddev:2.59 (3.4%) stddev-sans-first:2.42 02:52:10 INFO - PROCESS | 28454 | Values: 80.0 74.0 77.0 76.0 75.0 80.0 74.0 75.0 74.0 80.0 02:52:10 INFO - PROCESS | 28454 | 02:52:10 INFO - PROCESS | 28454 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:132.00 stddev:11.64 (8.8%) stddev-sans-first:12.34 02:52:10 INFO - PROCESS | 28454 | Values: 131.0 122.0 133.0 122.0 122.0 134.0 121.0 122.0 159.0 134.0 02:52:10 INFO - PROCESS | 28454 | 02:52:10 INFO - PROCESS | 28454 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.00 Median:154.00 stddev:2.62 (1.7%) stddev-sans-first:2.35 02:52:10 INFO - PROCESS | 28454 | Values: 150.0 152.0 154.0 151.0 159.0 154.0 154.0 156.0 154.0 156.0 02:52:10 INFO - PROCESS | 28454 | 02:52:10 INFO - PROCESS | 28454 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:64.50 stddev:4.15 (6.4%) stddev-sans-first:3.97 02:52:10 INFO - PROCESS | 28454 | Values: 70.0 68.0 63.0 64.0 62.0 62.0 62.0 65.0 60.0 73.0 02:52:10 INFO - PROCESS | 28454 | -------- Summary: end -------- 02:52:10 INFO - PROCESS | 28454 | 02:52:10 INFO - TEST-INFO | 28454: exit 0 02:52:11 INFO - TEST-OK | kraken | took 60506ms 02:52:11 INFO - SUITE-END | took 1173s 02:52:11 INFO - Completed test suite (00:19:33) 02:52:11 INFO - javascript benchmark 02:52:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7412.902491390049, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3262.983685081574, 3312.5196846457247, 3313.4532802087656, 3327.3678001179787, 3327.7005069543734, 5688.402717714637, 5743.195952566644, 5758.280214973129, 5768.278965129359, 5790.884182316346, 5772.0, 5821.18503409523, 5857.326407463143, 5864.354920958691, 5866.354700982888, 5285.841424757245, 5293.576513878899, 5327.733613319338, 5350.946490535103, 5368.141097424413, 5353.250544923714, 5369.582332599202, 5370.973145134269, 5371.973140134294, 5394.7842086316505, 5138.229265610151, 5147.1764517677175, 5338.599605029638, 5362.973185134068, 5374.48942350476, 5152.690838549699, 5153.072446959564, 5204.661696989683, 5248.265242866002, 5310.123829568117, 5150.201718733602, 5224.895502089937, 5252.159654455307, 5254.605904557136, 5286.471352864722, 5512.228288039678, 5658.207850900877, 5689.943100569024, 5762.135679648086, 5774.595778295521, 5983.461488466015, 5993.220881285405, 6010.96994515029, 6012.3085845127935, 6022.488088512482, 6017.338092809788, 6036.3360030396625, 6054.848628784272, 6114.510839132859, 6133.172021777093, 5716.714164291769, 5718.142278658234, 5723.627964182315, 5728.828135155952, 5732.5127364174095, 6119.929102025404, 6132.78535251264, 6133.640713961371, 6208.81373558794, 6216.658083805434, 5956.702164891824, 6010.579259451796, 6019.187409699722, 6021.066734656135, 6021.307549631761, 5954.55340849438, 5974.133750606138, 6117.449429551273, 6119.44924956756, 6127.479164271087, 6059.1820104286235, 6086.0, 6101.0, 6159.96920015406, 6175.197224360804, 6075.273636300304, 6134.110553969649, 6149.046897730859, 6154.5384096192965, 6164.0, 4606.539346065367, 4742.383490146259, 4745.786439610157, 4747.8100875965265, 4749.073930583572, 4143.585641435832, 4157.48031496063, 4174.749515029108, 4214.515330736943, 4238.173556156582, 5896.439838215363, 5935.465808077208, 5937.970310148508, 5953.017752070859, 5957.076653118774, 6120.17377654011, 6150.907736383958, 6170.660613666201, 6178.0424034273865, 6179.3820617937845, 5874.060150375919, 5894.587378883522, 5932.851678707981, 5952.0476723724, 5995.190649262381, 5322.893542129135, 5347.491988261109, 5361.705106219196, 5369.27514785499, 5374.1938709193155, 6501.642409667514, 6527.804165875032, 6567.704453299709, 6569.934300657028, 6576.76981305652, 5963.493103086286, 6027.849303767441, 6069.332373439007, 6069.393060693896, 6229.626222426669, 6395.744170233324, 6432.35676432353, 6443.516736244706, 6448.484121270193, 6449.7420103195345, 5968.6717230551, 6051.0, 6077.726502307495, 6080.148779171008, 6089.604175728564, 5953.077273022688, 5987.670678112746, 6056.485198758155, 6187.226596675416, 6189.226346706661, 5945.3757355477055, 6013.548983826318, 6036.245469316335, 6060.181875446759, 6062.636241825505, 5959.433853783884, 6011.0, 6015.759369625341, 6017.338092809699, 6020.157177994996, 5686.289213848269, 5712.771489140554, 5953.821385358447, 5959.374265702038, 5962.314333851663, 5902.0, 5909.734061967136, 5920.141579471038, 5970.164177015308, 5984.16221728967, 5760.510356619567, 5825.242718446575, 5830.708464576669, 5843.444872737083, 5852.0], "value": 5665.621880336974, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.7865889620838, 616.7502161624542, 628.0861346740492, 652.7454292825796, 665.8102440804365, 42391.78804105979, 43222.135557288835, 43260.134797304076, 45940.081198376014, 46365.7681711591, 44758.552414475846, 45001.77499112508, 45164.0967180657, 45254.77372613132, 45371.09257814842, 8762.561871906411, 8862.60118294675, 8863.335249856254, 8916.420432671888, 8916.465012099296, 8758.211760941515, 8803.95598022009, 8843.115688431137, 8876.245519130849, 8884.777880553005, 8878.422902511316, 8942.0, 8943.150400711922, 8949.64201431942, 8967.596458159398, 8853.29173666105, 8920.286377089817, 8921.375503714742, 8922.955385223033, 8925.062868398822, 8750.781230469225, 8756.649734010633, 8765.0, 8786.64853405863, 8813.515256660881, 41731.0, 42062.0, 42096.78951605253, 42131.7893410534, 42227.36658950118, 3256.299895522474, 3695.4826324314618, 3839.8080095995088, 3876.186000939806, 4096.016955930555, 32343.191420214447, 32561.51157732636, 32724.6727532724, 32772.508412373834, 32958.3408331832, 4491.663125265585, 4558.794854231567, 4565.543445655441, 4587.380703605004, 4600.3099535070005, 346553.0689386223, 348322.0, 348329.0, 348864.0, 350063.0, 60622.0, 61023.0, 61417.0, 61427.692861535405, 61527.6923615388, 58899.41100588939, 59061.70469147627, 59284.7035764827, 59484.70257648684, 59692.0, 14469.710605787825, 14503.709925801424, 14572.562823115324, 14735.0, 14789.482368117064, 10980.505877235544, 10992.670219893416, 11016.228863979444, 11023.228374013743, 11101.944490277498, 17320.39378621742, 18304.0, 18309.633807324044, 18334.0, 18349.0, 6106.572539922252, 6152.569320147636, 6162.876742465126, 6304.432601065834, 6315.96842015787, 951.3958636266021, 996.461910568285, 1014.5890914179769, 1023.6007956896816, 1118.6755840806075, 30732.38535229283, 31132.221694457367, 31299.68700312968, 31800.204994875312, 32556.186095347806, 1032.695354870315, 1111.1721767283263, 1119.160629527854, 1145.9885401146048, 1256.918300310477, 16217.696014016814, 16353.34586616522, 16990.0, 17653.911730441523, 17723.29106835712, 496350.0, 511079.0, 511965.0, 514039.0, 514909.0, 60521.0, 60549.0, 60698.39301607016, 60864.0, 60900.0, 1354.2483921423507, 1363.9931800340935, 1365.5834970333945, 1380.4133243371527, 1410.9647258818406, 31095.0, 32761.67238327586, 33146.33707325888, 33232.0, 33375.81910060157, 52905.0, 53190.0, 53222.4677753233, 53312.2003169945, 53552.0, 418559.0, 419379.0, 421548.0, 422789.0, 422966.0, 29539.113826585235, 29739.55390669185, 29866.0, 30129.24676883008, 30179.245518862204, 47653.523464766295, 47922.281165781846, 48445.75777121092, 48492.5150748488, 48494.757526212146, 39969.0, 40059.0, 40334.0, 41236.175276494905, 42103.57896421119, 39435.2112957745, 41148.1770364597, 42123.0, 42244.36633450439, 42394.78802605967, 40312.39531406973, 40757.59242407538, 40895.795521022206, 41989.1602167961, 43368.0, 34984.47523287102, 36478.63521364859, 36826.0, 36996.26007479889, 37642.0, 28542.85728571344, 28887.133385998455, 28983.710162898944, 29072.41855162927, 29287.560686590143], "value": 20060.588778328558, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.4554242857001, 421.6984855828084, 428.26967424374556, 430.6059955141045, 435.3448060668693, 18443.26226950922, 19040.7151141863, 19995.900020499877, 20326.288579899705, 20606.866622335765, 19151.42545723627, 19285.0, 19390.806091939077, 19647.0, 19685.311014114508, 5724.656520608777, 5900.498457631106, 5928.318243402021, 5962.612430192024, 5972.761089556412, 5653.575981801361, 5736.139579063132, 5872.412758724115, 5949.226600541923, 5960.731767070492, 5861.912071318934, 5863.061910094386, 5902.291724992985, 5906.497947674453, 5907.527397808187, 5580.414056524068, 5770.711464426762, 5814.651120932736, 5818.767249310023, 5899.793507227248, 5199.194124910645, 5202.869928251824, 5205.505476979719, 5206.114960456732, 5207.895842083175, 23120.190793322323, 23209.419764505852, 23860.284191474282, 23922.880385598135, 23996.0, 2399.652050452692, 2436.50051739393, 2461.0770960889668, 2585.2631999879945, 2694.178275625933, 14633.414663413558, 15367.077975321405, 15404.537863864101, 15531.844681553153, 15815.706722525169, 1964.2535836382226, 1975.3283883479685, 2060.320094368855, 2115.4288342147534, 2126.723525941633, 83209.0, 84200.57899710462, 85114.99999999937, 85621.57189214077, 86518.0, 10710.410927398912, 10807.243492955418, 10885.346879187275, 11223.60717374888, 11373.886261137448, 14199.432022719182, 14215.644608884653, 14244.715105697827, 14263.215523146118, 14347.92826035863, 7676.078870535572, 7685.884711729329, 7834.255745704149, 7859.096203936506, 7903.68385264583, 7171.1394632644415, 7297.0, 7309.232530584319, 7452.590107544029, 7452.776416707399, 6538.640374779433, 6694.899576506259, 6778.22050464193, 6807.557508762014, 6873.896891546631, 2000.6698894682215, 2089.822365098953, 2095.5599324141795, 2096.6854971754055, 2108.820750236247, 919.3242966419676, 1010.7877345757473, 1049.2130901823632, 1071.5767271927546, 1088.7822435512928, 20208.191672333236, 20321.89839050795, 20420.897895510723, 20513.076911539018, 20785.272515461886, 1046.9110125639254, 1059.427908929185, 1071.244772435431, 1106.1416819742908, 1120.9743085077064, 11027.2280940335, 11650.184487085822, 11690.941545292219, 11706.297622142698, 11758.764824703629, 472803.0, 473599.0, 475520.0, 478981.0, 486695.0, 80229.59885200537, 83269.58365208257, 84078.57960710158, 84375.0, 85870.0, 1000.1348833259178, 1041.8489319048695, 1056.6829951014818, 1065.872095348563, 1074.897884700952, 18121.456356309332, 18649.254029838656, 18673.0, 18801.717974230673, 18921.716174257122, 40174.0, 45758.313625296316, 45897.08205835798, 46014.309785352576, 46109.0, 63130.36869631245, 63963.68018159879, 64497.67751161214, 64514.0, 65388.0, 7994.200579941959, 8824.91175088241, 8917.0, 9268.165865072177, 9272.350935434724, 13013.154144980546, 13687.589372318846, 13766.174029558259, 13798.724025519232, 13847.238401887993, 11964.880351196376, 11965.521379144737, 12104.878951210376, 12200.206986545845, 12390.442430090487, 11552.82670759956, 11596.130290228435, 11751.353675547927, 11939.223950443193, 11991.0, 12224.144309898578, 12245.387730613611, 12306.446209920396, 12311.56909508163, 12381.257124572194, 8486.702965396182, 8492.490450572985, 8583.098774628825, 8654.264387527131, 8738.475691458532, 10792.406417647106, 11113.277636953571, 11466.82799758021, 11936.641900742992, 12036.578719744766], "value": 9615.583298310034, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.3643033495598, 1478.9482368117115, 1633.4854520825938, 1754.754124571554, 1795.9640807183864, 8056.758297251077, 8303.0, 8472.279856212223, 9149.725508234747, 9171.770705732351, 8540.316774658027, 8805.471671699703, 8820.162084601969, 9050.32122590805, 9102.13529714676, 2426.817988650849, 2479.404942813721, 2496.0639760089966, 2503.211488381154, 2505.1983365323103, 2443.816713746467, 2554.4124851284214, 2555.9616605750834, 2556.4120252341972, 2558.2453176313034, 2470.22188010776, 2471.209213051824, 2471.468634243637, 2485.639582260571, 2494.3514686181634, 2479.6156595727603, 2486.8383555068863, 2504.6743923290037, 2510.7740303372602, 2514.019532382354, 2494.6756921600077, 2494.825362224645, 2495.089292408276, 2514.861682607456, 2521.2688320387065, 9007.964084130343, 9014.18872301496, 9083.409578377385, 9161.496117713523, 9188.081191880825, 5430.70131142787, 5500.642458240201, 5524.696141712204, 5527.585431092644, 5535.778568857241, 3372.359251742161, 3523.4186359250693, 3545.3441113394106, 3569.250457403948, 3613.241219343941, 1094.6606551968914, 1133.3709791065955, 1157.3634501024487, 1157.6816375496805, 1184.9644510664693, 12584.874151258553, 12714.809277860839, 12717.936410317889, 12739.04457165707, 12769.808452873214, 4707.0, 4792.664513484023, 4891.437484689306, 4899.216125419915, 4958.57852082577, 10699.94650026745, 10700.732481688021, 10759.515821787882, 10776.407297598551, 10803.243772935975, 5578.023845826964, 5578.497935185853, 5580.665160090326, 5586.385497595261, 5586.608937374344, 4922.704637721748, 4976.303317535548, 5080.110980578458, 5097.8215762448135, 5111.875387414762, 3773.113318370181, 3824.7896365700153, 3838.616138386139, 3899.6880249579967, 3914.2758589660434, 1222.468226321553, 1225.3444407242082, 1230.9076819238594, 1237.5111830826772, 1248.3820508848178, 833.4999000599713, 979.2215188924822, 982.1995074014656, 1003.6988903328972, 1009.7223263602568, 6013.51891848651, 6052.364501727343, 6198.318184999646, 6204.689765511706, 6218.875622487525, 446.73865788513433, 1028.5422986770964, 1029.0275689473376, 1069.51871657753, 1100.790849738563, 3683.042408973686, 3684.9447258291148, 3726.9627303727157, 3757.1358587524473, 3757.1546402059867, 10619.84070238947, 10793.784124317626, 10950.726231844268, 10966.835497467544, 10981.6156434526, 10822.188335874684, 10883.292585981886, 10907.345559266469, 10939.945300273448, 10977.780444391068, 8038.437309388403, 8396.412251142483, 8489.702860399857, 8664.09027052163, 8686.087960764155, 5870.7945221917025, 5874.911876321773, 6038.215032045806, 6128.938710612837, 6244.375562443719, 10294.691159265234, 10299.742506437398, 10420.374777513374, 10453.320534165256, 10476.528556214836, 10383.584656613652, 10509.527071281658, 10529.368237905444, 10547.525361358605, 10597.205209609465, 7518.398528117628, 7727.034120734908, 7779.299863012356, 7894.605269736376, 8115.75652730419, 8688.956555217184, 8713.259372953116, 8720.825583488422, 8738.956305218433, 8746.781330466534, 7694.538327700356, 7699.769006929801, 7858.371330293448, 7911.327537159406, 7933.206679332251, 7700.768976930701, 7725.072991241087, 7738.0, 7767.300942915164, 7905.01187351581, 7268.454865884974, 7325.853482930205, 7330.340269375782, 7338.229485904117, 7367.0, 5279.788808447773, 5346.25152478661, 5382.0, 5539.0, 5606.719664016864, 5109.335786347751, 5162.122439185272, 5184.403793563638, 5198.16829307309, 5232.633715639869], "value": 4761.91365696505, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.9557555305587, 362.3459655322142, 362.9473726309685, 363.4874826494643, 363.9745217834751, 5622.4939755422, 5642.3511296200895, 5668.574856885734, 5685.886282274352, 5689.715514224283, 5530.751116199771, 5581.609287349887, 5582.748776305066, 5592.993261212991, 5610.326760788701, 4166.5833416658315, 4230.957690423103, 4332.350147477872, 4346.152885023868, 4367.978160109195, 4315.525292217853, 4326.8269269229195, 4332.523422423531, 4348.586884245991, 4364.018095928423, 4309.612134907858, 4312.676549258803, 4333.263345231302, 4336.132773445308, 4355.36847157162, 4193.706440549147, 4297.23991507431, 4298.914021719579, 4323.65410767141, 4340.131973605276, 3818.503594532693, 3825.0, 3832.2527107214105, 3835.654791068789, 3836.405357169643, 5399.271098401744, 5402.568319395364, 5418.972905135449, 5421.671690435829, 5422.240886275925, 4801.5438533339275, 4919.72941488218, 4968.925466118011, 4975.328330675348, 4987.226979818134, 5777.62445441045, 5810.651360918316, 5818.825435236908, 5828.821449263752, 5847.707614619295, 4186.958130418718, 4190.371444283352, 4210.663146948237, 4215.473065866767, 4225.809838557272, 5797.608399086539, 5855.619384739978, 5963.970180149072, 5994.13085102662, 5996.4902983246475, 4250.553691862372, 4270.850520231839, 4271.444712187395, 4273.401723758676, 4275.444192254987, 4280.892977675583, 4312.116016216668, 4341.131773645284, 4355.433793606874, 4391.516933137353, 4877.268409738496, 4974.0, 4978.701277923336, 4986.152354099811, 5003.524665156804, 5815.331236907725, 5846.6784326862435, 5852.356240813507, 5874.706264686749, 5900.203472531153, 1452.5111760445627, 1457.846926072747, 1464.648484363745, 1470.154661069889, 1476.6382236351947, 983.7835676151235, 1018.5162048027128, 1018.8369860822381, 1032.9586816527406, 1033.5297439665085, 5587.93829172464, 5606.1590761385305, 5637.633553818989, 5643.661380317194, 5661.716914154275, 5879.617824841372, 5891.641764194454, 5930.525557955353, 5933.703314834241, 5958.076498142795, 5389.407165211824, 5530.391656917735, 5540.556755459635, 5554.556175171419, 5627.887442251132, 3028.545718142296, 3059.7399221066457, 3067.907962761121, 3077.415291094685, 3093.3503964167326, 5870.0, 6105.8168254952425, 6130.203073600493, 6133.0, 6134.570580059353, 5825.456254092669, 5851.824445266564, 5875.441833025856, 5882.3529411764675, 5888.671826207734, 6046.425589568984, 6058.153072798805, 6059.242594675666, 6105.9694701526205, 6119.816405507842, 5697.886042279214, 5783.421657834351, 5940.0, 5991.520678345635, 6025.8192254232445, 5935.287765467999, 5941.643501389931, 5943.64338139713, 5955.196048533393, 5983.354577491051, 6163.753449862134, 6312.495000399865, 6335.809925702236, 6339.7954388666, 6474.1907261592305, 4314.482262128565, 4347.217500849751, 4363.105563359567, 4365.4979677337515, 4367.781610919505, 5790.739416726173, 6076.0, 6102.237220347457, 6119.938800612115, 6153.661548614869, 5868.0, 5907.3797251288, 5971.536973441534, 5974.1934838796205, 5979.103134529855, 5789.971050144891, 5918.852028699317, 5929.822105336847, 5936.584439089395, 5966.403359663999, 5657.4908258256955, 5823.621464604787, 5848.0, 5873.559483038704, 5912.320083190316, 5923.614965027259, 5953.642781433128, 5955.808838232458, 5959.73181206838, 5979.252593425822, 5644.745986430538, 5726.284214473191, 5780.976658169607, 5808.477237048686, 5822.70886455667], "value": 4458.3741850283095, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.4211404534237, 703.9120109986255, 732.77284041947, 748.7341993592278, 817.918208179182, 13783.173009619404, 13960.860391396096, 13987.510437134702, 13990.580282591525, 14779.334929928153, 14462.204578748164, 14631.707365852677, 14757.0, 15013.0, 15018.474353397633, 817.7138001699402, 830.4933990265963, 832.6627715775121, 833.6540335760652, 833.8374017066675, 803.602216902634, 825.145973916996, 832.546262287055, 837.4640230252643, 838.3125836813815, 875.1467319363601, 875.5228400521731, 877.5787621941472, 877.8858748362704, 878.3280790195473, 870.1776820904248, 871.7907702151501, 873.2708188662411, 874.3617159473556, 874.7157173918438, 636.859890824018, 641.720851429625, 644.8968165093562, 646.001927022751, 646.0857886091176, 15077.396904123932, 15402.0, 15452.459163929321, 15477.148756818371, 15481.458148964732, 14189.290535473185, 14940.701185976219, 15025.323860426308, 15076.170810605412, 15112.773308400383, 11496.137789665809, 11583.594574189947, 11625.883741162565, 11792.882071179265, 11945.581904633384, 3711.406175012012, 3752.887413377603, 3764.7176461765202, 3795.7532760370764, 3832.1952389998132, 66632.3336766631, 67502.0, 67503.66248168728, 68185.31814681839, 68362.3163768361, 9886.357386769838, 10299.227557933185, 10728.839067413996, 10993.285436446606, 11359.20485566019, 20475.692864607045, 20548.07533660959, 20550.07524661394, 20713.96430178485, 20845.0, 8102.675892964333, 8139.95930020358, 8221.095679475253, 8250.628721707537, 8545.700900468579, 4573.634109271316, 4624.491305956342, 4653.2554791233915, 4680.648951328664, 4696.272077827942, 3410.48842673596, 3504.7021003214504, 3507.877224297137, 3516.1385460561814, 3538.610752817188, 610.4627927423838, 627.8807026664919, 631.4443289904855, 637.3180696654628, 649.3084864619166, 619.3032838057186, 674.4031532094034, 675.3381685947799, 678.9456843452512, 720.1070672366228, 8515.701950431829, 8760.167784060504, 8958.68644597449, 9090.636374544943, 9208.217301529312, 502.0962267917806, 606.3814908793095, 614.2536817766346, 634.346622978333, 716.0905649824798, 4217.536071032184, 4269.850555230552, 4293.849715259951, 4316.201502722007, 4483.267203321187, 91352.54323728471, 91774.54112729528, 94211.52894235485, 95578.0, 98228.0, 82079.58960205161, 82885.0, 83114.58442707748, 84421.57789211014, 87027.56486217654, 75128.62435687786, 75292.62353688196, 75389.6230518844, 77191.0, 78644.60677696575, 7885.0, 8070.435069545076, 8437.535935523605, 8471.491710497143, 8511.36164787631, 48156.27765583449, 48848.0, 48848.75575622099, 49043.50956490532, 49210.75394623004, 64155.0, 65989.0, 69281.65359173373, 69638.65180674064, 72131.27868721246, 10750.516226769658, 10968.17738669587, 11303.152263580429, 11605.30368177912, 11864.169508134348, 13470.52853150135, 13493.32533373347, 13510.459581616626, 13530.255835929118, 13532.86467135316, 11961.0, 12064.51741930348, 12172.878271217174, 12444.128910976146, 12600.243985360541, 12341.691457713629, 12396.504139834306, 12521.812172817597, 12573.497060117494, 12703.555375561811, 10651.147908167482, 11489.655310340702, 11649.953148985967, 11701.414929253673, 12002.879971200176, 10832.891671083189, 11214.048258443205, 11372.829407558727, 11549.281723862796, 11702.765944681229, 10456.058954694114, 10560.260781745204, 10576.524056417325, 10717.571297148026, 10796.298240614335], "value": 7150.946201653179, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1470.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 113.0, 113.0, 114.0, 113.0, 114.0, 113.0, 115.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 126.0, 123.0, 165.0, 121.0, 126.0, 123.0, 122.0, 152.0, 122.0], "value": 132.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 165.0, 163.0, 161.0, 164.0, 162.0, 162.0, 164.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 113.0, 76.0, 76.0, 76.0, 75.0, 109.0, 77.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 111.0, 84.0, 83.0, 81.0, 96.0, 82.0, 81.0, 115.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 123.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 124.0], "value": 118.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 148.0, 149.0, 148.0, 148.0, 147.0, 146.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 86.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 54.0, 53.0, 57.0, 54.0, 55.0, 53.0, 53.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 59.0, 59.0, 60.0, 59.0, 61.0, 59.0, 61.0, 59.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 74.0, 77.0, 76.0, 75.0, 80.0, 74.0, 75.0, 74.0, 80.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 122.0, 133.0, 122.0, 122.0, 134.0, 121.0, 122.0, 159.0, 134.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 154.0, 151.0, 159.0, 154.0, 154.0, 156.0, 154.0, 156.0], "value": 154.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 63.0, 64.0, 62.0, 62.0, 62.0, 65.0, 60.0, 73.0], "value": 64.9, "unit": "score"}]}]} 02:52:11 INFO - Return code: 0 02:52:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:52:11 ERROR - # TBPL SUCCESS # 02:52:11 INFO - Running post-action listener: _resource_record_post_action 02:52:11 INFO - [mozharness: 2017-01-11 10:52:11.305331Z] Finished run-tests step (success) 02:52:11 INFO - Running post-run listener: _resource_record_post_run 02:52:11 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 355491840; Read time: 8; Write time: 232660 02:52:11 INFO - TinderboxPrint: CPU usage
13.3% 02:52:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:52:11 INFO - TinderboxPrint: I/O write bytes / time
355,491,840 / 232,660 02:52:11 INFO - TinderboxPrint: CPU idle
8,221.2 (86.7%) 02:52:11 INFO - TinderboxPrint: CPU user
1,206.9 (12.7%) 02:52:11 INFO - TinderboxPrint: Swap in / out
0 / 0 02:52:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108167168; Read time: 0; Write time: 99400 02:52:11 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 247009280; Read time: 0; Write time: 133260 02:52:11 INFO - Running post-run listener: _upload_blobber_files 02:52:11 INFO - Blob upload gear active. 02:52:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:52:11 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 02:52:11 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:52:11 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:52:12 INFO - (blobuploader) - INFO - Open directory for files ... 02:52:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:52:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:52:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:13 INFO - (blobuploader) - INFO - Done attempting. 02:52:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:52:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:52:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:16 INFO - (blobuploader) - INFO - Done attempting. 02:52:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:52:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:52:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:17 INFO - (blobuploader) - INFO - Done attempting. 02:52:17 INFO - (blobuploader) - INFO - Iteration through files over. 02:52:17 INFO - Return code: 0 02:52:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:52:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:52:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d54ca5ff2b7db8f164af44a3b0fd87c836fa7c1f04fb3617b52c06e7ea586e37bb796e5db4ea89c7ee7a75f34ab2d258b73b4dd897edec2d1f4282cb36f385fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc3f2d0e138c19b0aa954df3878c4dbdbc272a8776ac5ed92eb3872e15e0ec5f14bf57a9ffcea31aed080b394715a8d702ac2f203daaa79018e2df154893243e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea140372c230de0e812647079eefeda0b18b2d96a7e824434f9113c6b32f74a12f05d6221ebf45eb7847fdb6a0cf7eae4e4954c7e61fa553a429d2705a087f4f"} 02:52:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:52:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:52:17 INFO - Contents: 02:52:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d54ca5ff2b7db8f164af44a3b0fd87c836fa7c1f04fb3617b52c06e7ea586e37bb796e5db4ea89c7ee7a75f34ab2d258b73b4dd897edec2d1f4282cb36f385fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc3f2d0e138c19b0aa954df3878c4dbdbc272a8776ac5ed92eb3872e15e0ec5f14bf57a9ffcea31aed080b394715a8d702ac2f203daaa79018e2df154893243e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea140372c230de0e812647079eefeda0b18b2d96a7e824434f9113c6b32f74a12f05d6221ebf45eb7847fdb6a0cf7eae4e4954c7e61fa553a429d2705a087f4f"} 02:52:17 INFO - Running post-run listener: copy_logs_to_upload_dir 02:52:17 INFO - Copying logs to upload dir... 02:52:17 INFO - mkdir: /builds/slave/test/build/upload/logs 02:52:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.521951 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-11 02:52:16.669675) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 02:52:16.673593) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787 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-Aurora/sha512/d54ca5ff2b7db8f164af44a3b0fd87c836fa7c1f04fb3617b52c06e7ea586e37bb796e5db4ea89c7ee7a75f34ab2d258b73b4dd897edec2d1f4282cb36f385fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc3f2d0e138c19b0aa954df3878c4dbdbc272a8776ac5ed92eb3872e15e0ec5f14bf57a9ffcea31aed080b394715a8d702ac2f203daaa79018e2df154893243e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea140372c230de0e812647079eefeda0b18b2d96a7e824434f9113c6b32f74a12f05d6221ebf45eb7847fdb6a0cf7eae4e4954c7e61fa553a429d2705a087f4f"} build_url:https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/H1y2yFbXRc2CpZtKdp8e3A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d54ca5ff2b7db8f164af44a3b0fd87c836fa7c1f04fb3617b52c06e7ea586e37bb796e5db4ea89c7ee7a75f34ab2d258b73b4dd897edec2d1f4282cb36f385fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc3f2d0e138c19b0aa954df3878c4dbdbc272a8776ac5ed92eb3872e15e0ec5f14bf57a9ffcea31aed080b394715a8d702ac2f203daaa79018e2df154893243e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea140372c230de0e812647079eefeda0b18b2d96a7e824434f9113c6b32f74a12f05d6221ebf45eb7847fdb6a0cf7eae4e4954c7e61fa553a429d2705a087f4f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 02:52:16.701262) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 02:52:16.701623) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1484130699.561004-455349787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 02:52:16.786244) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 02:52:16.786871) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 02:52:16.787560) ========= ========= Total master_lag: 0.84 =========