builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1483719805.53 results: success (0) buildid: 20170106063601 builduid: 6442de13ea6b4e6da98a966ed88505cd revision: 0c3414e6f0b2535f7b7668e835fbfe2401c43bb0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 08:23:25.528840) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 08:23:25.529298) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 08:23:25.529592) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 08:23:25.544442) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 08:23:25.544772) ========= 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=c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-06 08:23:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.5M=0s 2017-01-06 08:23:25 (70.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126324 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 08:23:25.684862) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 08:23:25.685192) ========= 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=c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018096 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 08:23:25.734437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 08:23:25.734802) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0c3414e6f0b2535f7b7668e835fbfe2401c43bb0 --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 0c3414e6f0b2535f7b7668e835fbfe2401c43bb0 --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=c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-06 08:23:25,819 truncating revision to first 12 chars 2017-01-06 08:23:25,819 Setting DEBUG logging. 2017-01-06 08:23:25,819 attempt 1/10 2017-01-06 08:23:25,819 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0c3414e6f0b2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-06 08:23:26,118 unpacking tar archive at: mozilla-aurora-0c3414e6f0b2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.674703 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 08:23:26.423413) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 08:23:26.423785) ========= script_repo_revision: 0c3414e6f0b2535f7b7668e835fbfe2401c43bb0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 08:23:26.424178) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 08:23:26.424443) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 08:23:26.434474) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-01-06 08:23:26.434838) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:23:26 INFO - MultiFileLogger online at 20170106 08:23:26 in /builds/slave/test 08:23:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:23:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:23:26 INFO - {'append_to_log': False, 08:23:26 INFO - 'base_work_dir': '/builds/slave/test', 08:23:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:23:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:23:26 INFO - 'branch': 'Mozilla-Aurora', 08:23:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:23:26 INFO - 'config_files': ('talos/linux_config.py',), 08:23:26 INFO - 'default_actions': ('clobber', 08:23:26 INFO - 'read-buildbot-config', 08:23:26 INFO - 'download-and-extract', 08:23:26 INFO - 'populate-webroot', 08:23:26 INFO - 'create-virtualenv', 08:23:26 INFO - 'install', 08:23:26 INFO - 'run-tests'), 08:23:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:23:26 INFO - 'download_minidump_stackwalk': True, 08:23:26 INFO - 'download_symbols': 'ondemand', 08:23:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:23:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:23:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:23:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:23:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:23:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:23:26 INFO - 'installer_path': 'installer.exe', 08:23:26 INFO - 'log_level': 'info', 08:23:26 INFO - 'log_name': 'talos', 08:23:26 INFO - 'log_to_console': True, 08:23:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:23:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:23:26 INFO - 'opt_config_files': (), 08:23:26 INFO - 'pip_index': False, 08:23:26 INFO - 'sps_profile': False, 08:23:26 INFO - 'sps_profile_interval': 0, 08:23:26 INFO - 'suite': 'dromaeojs', 08:23:26 INFO - 'system_bits': '32', 08:23:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:23:26 INFO - 'title': 'talos-linux64-ix-004', 08:23:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:23:26 INFO - 'use_talos_json': True, 08:23:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:23:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:23:26 INFO - 'work_dir': 'build'} 08:23:26 INFO - [mozharness: 2017-01-06 16:23:26.615739Z] Running clobber step. 08:23:26 INFO - Running pre-action listener: _resource_record_pre_action 08:23:26 INFO - Running main action method: clobber 08:23:26 INFO - rmtree: /builds/slave/test/build 08:23:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:23:27 INFO - Running post-action listener: _resource_record_post_action 08:23:27 INFO - [mozharness: 2017-01-06 16:23:27.686150Z] Finished clobber step (success) 08:23:27 INFO - [mozharness: 2017-01-06 16:23:27.686248Z] Running read-buildbot-config step. 08:23:27 INFO - Running pre-action listener: _resource_record_pre_action 08:23:27 INFO - Running main action method: read_buildbot_config 08:23:27 INFO - Using buildbot properties: 08:23:27 INFO - { 08:23:27 INFO - "project": "", 08:23:27 INFO - "product": "firefox", 08:23:27 INFO - "script_repo_revision": "production", 08:23:27 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:23:27 INFO - "repository": "", 08:23:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:23:27 INFO - "buildid": "20170106063601", 08:23:27 INFO - "pgo_build": "True", 08:23:27 INFO - "basedir": "/builds/slave/test", 08:23:27 INFO - "buildnumber": 997, 08:23:27 INFO - "slavename": "talos-linux64-ix-004", 08:23:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:23:27 INFO - "platform": "ubuntu64_hw", 08:23:27 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:23:27 INFO - "branch": "mozilla-aurora", 08:23:27 INFO - "repo_path": "releases/mozilla-aurora", 08:23:27 INFO - "revision": "0c3414e6f0b2535f7b7668e835fbfe2401c43bb0", 08:23:27 INFO - "stage_platform": "linux64-pgo", 08:23:27 INFO - "builduid": "6442de13ea6b4e6da98a966ed88505cd", 08:23:27 INFO - "slavebuilddir": "test" 08:23:27 INFO - } 08:23:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:23:27 INFO - Running post-action listener: _resource_record_post_action 08:23:27 INFO - [mozharness: 2017-01-06 16:23:27.688669Z] Finished read-buildbot-config step (success) 08:23:27 INFO - [mozharness: 2017-01-06 16:23:27.688757Z] Running download-and-extract step. 08:23:27 INFO - Running pre-action listener: _resource_record_pre_action 08:23:27 INFO - Running main action method: download_and_extract 08:23:27 INFO - mkdir: /builds/slave/test/build/tests 08:23:27 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')]} 08:23:27 INFO - trying https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:23:27 INFO - Downloading https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/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 08:23:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/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 08:23:28 INFO - Downloaded 1361 bytes. 08:23:28 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:23:28 INFO - Using the following test package requirements: 08:23:28 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:23:28 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:23:28 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:23:28 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:23:28 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:23:28 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:23:28 INFO - u'jsshell-linux-x86_64.zip'], 08:23:28 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:23:28 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:23:28 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:23:28 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:23:28 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:23:28 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:23:28 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:23:28 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:23:28 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:23:28 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:23:28 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:23:28 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:23:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:23:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:23:28 INFO - Fetch https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:23:28 INFO - Http code: 200 08:23:28 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 08:23:28 INFO - x-amz-cf-id: 0BSTXtTEEpTfGm7hXVThNyBUwXgbM8zAAfFSpL9LNyO1pBFnz4hCtA== 08:23:28 INFO - x-amz-version-id: 2Ob_6YCn7G3PJ6DaShOVqlIO1JnbqPsR 08:23:29 INFO - Expected file size: 21942462 08:23:29 INFO - Obtained file size: 21942462 08:23:33 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 08:23:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:23:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:23:33 INFO - Fetch https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:23:33 INFO - Http code: 200 08:23:33 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 08:23:33 INFO - x-amz-cf-id: T6ho-8hkeQvKwRaZQ3BEPuoWo3xNRQv0lqy_y1wGfezYCsThJBk6Xg== 08:23:33 INFO - x-amz-version-id: 2Ob_6YCn7G3PJ6DaShOVqlIO1JnbqPsR 08:23:33 INFO - Expected file size: 21942462 08:23:33 INFO - Obtained file size: 21942462 08:23:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:23:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:23:38 INFO - Fetch https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:23:38 INFO - Http code: 200 08:23:38 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 08:23:38 INFO - x-amz-cf-id: TSiCuKnooUSZ_VQFW7shtraf24wkFNA1d0-DLclWRuYBwa3mF8GoNw== 08:23:38 INFO - x-amz-version-id: zpPhHHsiffBueJYeiZhD_Z7tm2gxgHq3 08:23:39 INFO - Expected file size: 14409038 08:23:39 INFO - Obtained file size: 14409038 08:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:39 INFO - trying https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:23:39 INFO - Downloading https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/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 08:23:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/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 08:23:41 INFO - Downloaded 64089186 bytes. 08:23:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:23:41 INFO - mkdir: /builds/slave/test/properties 08:23:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:23:41 INFO - Writing to file /builds/slave/test/properties/build_url 08:23:41 INFO - Contents: 08:23:41 INFO - build_url:https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:23:41 INFO - Running post-action listener: _resource_record_post_action 08:23:41 INFO - Running post-action listener: set_extra_try_arguments 08:23:41 INFO - [mozharness: 2017-01-06 16:23:41.735146Z] Finished download-and-extract step (success) 08:23:41 INFO - [mozharness: 2017-01-06 16:23:41.735370Z] Running populate-webroot step. 08:23:41 INFO - Running pre-action listener: _resource_record_pre_action 08:23:41 INFO - Running main action method: populate_webroot 08:23:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:23:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:23:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:23:41 INFO - '--tppagecycles', 08:23:41 INFO - '7'], 08:23:41 INFO - 'tests': ['tsvgm']}}, 08:23:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:23:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:23:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:23:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:23:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:23:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:23:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:41 INFO - 'talos_options': ['--disable-e10s'], 08:23:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:41 INFO - 'talos_options': ['--disable-e10s'], 08:23:41 INFO - 'tests': ['damp', 'tps']}, 08:23:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:41 INFO - 'tests': ['damp', 'tps']}, 08:23:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:23:41 INFO - 'tests': ['dromaeo_dom']}, 08:23:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:23:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:23:41 INFO - 'tests': ['basic_compositor_video']}, 08:23:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:23:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:23:41 INFO - 'tests': ['a11yr', 08:23:41 INFO - 'ts_paint', 08:23:41 INFO - 'tpaint', 08:23:41 INFO - 'sessionrestore', 08:23:41 INFO - 'sessionrestore_no_auto_restore', 08:23:41 INFO - 'tabpaint']}, 08:23:41 INFO - 'other-e10s': {'tests': ['a11yr', 08:23:41 INFO - 'ts_paint', 08:23:41 INFO - 'tpaint', 08:23:41 INFO - 'sessionrestore', 08:23:41 INFO - 'sessionrestore_no_auto_restore', 08:23:41 INFO - 'tabpaint']}, 08:23:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:23:41 INFO - 'ts_paint', 08:23:41 INFO - 'tpaint', 08:23:41 INFO - 'sessionrestore', 08:23:41 INFO - 'sessionrestore_no_auto_restore', 08:23:41 INFO - 'tabpaint']}, 08:23:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:23:41 INFO - 'ts_paint', 08:23:41 INFO - 'tpaint', 08:23:41 INFO - 'sessionrestore', 08:23:41 INFO - 'sessionrestore_no_auto_restore', 08:23:41 INFO - 'tabpaint']}, 08:23:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:23:41 INFO - 'tests': ['a11yr', 08:23:41 INFO - 'ts_paint', 08:23:41 INFO - 'tpaint', 08:23:41 INFO - 'sessionrestore', 08:23:41 INFO - 'sessionrestore_no_auto_restore', 08:23:41 INFO - 'tabpaint']}, 08:23:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:23:41 INFO - 'tests': ['a11yr', 08:23:41 INFO - 'ts_paint', 08:23:41 INFO - 'tpaint', 08:23:41 INFO - 'sessionrestore', 08:23:41 INFO - 'sessionrestore_no_auto_restore', 08:23:41 INFO - 'tabpaint']}, 08:23:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:23:41 INFO - 'tests': ['tsvgx', 08:23:41 INFO - 'tsvgr_opacity', 08:23:41 INFO - 'tart', 08:23:41 INFO - 'tscrollx', 08:23:41 INFO - 'cart']}, 08:23:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:23:41 INFO - 'tsvgr_opacity', 08:23:41 INFO - 'tart', 08:23:41 INFO - 'tscrollx', 08:23:41 INFO - 'cart']}, 08:23:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:41 INFO - 'talos_options': ['--disable-e10s'], 08:23:41 INFO - 'tests': ['tp5o']}, 08:23:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:41 INFO - 'tests': ['tp5o']}, 08:23:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:41 INFO - 'talos_options': ['--disable-e10s', 08:23:41 INFO - '--xperf_path', 08:23:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:41 INFO - 'tests': ['tp5n']}, 08:23:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:41 INFO - 'talos_options': ['--xperf_path', 08:23:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:41 INFO - 'tests': ['tp5n']}}, 08:23:41 INFO - 'talos.zip': {'path': '', 08:23:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:23:41 INFO - Running post-action listener: _resource_record_post_action 08:23:41 INFO - [mozharness: 2017-01-06 16:23:41.753841Z] Finished populate-webroot step (success) 08:23:41 INFO - [mozharness: 2017-01-06 16:23:41.753928Z] Running create-virtualenv step. 08:23:41 INFO - Running pre-action listener: _resource_record_pre_action 08:23:41 INFO - Running main action method: create_virtualenv 08:23:41 INFO - Creating virtualenv /builds/slave/test/build/venv 08:23:41 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 08:23:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:23:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:23:41 INFO - Using real prefix '/usr' 08:23:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:23:42 INFO - Installing distribute.............................................................................................................................................................................................done. 08:23:44 INFO - Installing pip.................done. 08:23:44 INFO - Return code: 0 08:23:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:23:44 INFO - Reading from file tmpfile_stdout 08:23:44 INFO - Output received: 08:23:44 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) 08:23:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:44 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 0x7f47d47f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2f60>, '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 0xdc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc41d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', '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 08:23:44 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 08:23:44 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 08:23:44 INFO - Using env: {'DISPLAY': ':0', 08:23:44 INFO - 'HOME': '/home/cltbld', 08:23:44 INFO - 'LANG': 'en_US.UTF-8', 08:23:44 INFO - 'LANGUAGE': 'en_US:en', 08:23:44 INFO - 'LOGNAME': 'cltbld', 08:23:44 INFO - 'MAIL': '/var/mail/cltbld', 08:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:44 INFO - 'MOZ_NO_REMOTE': '1', 08:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:44 INFO - 'NO_EM_RESTART': '1', 08:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:44 INFO - 'PWD': '/builds/slave/test', 08:23:44 INFO - 'SHELL': '/bin/bash', 08:23:44 INFO - 'SHLVL': '1', 08:23:44 INFO - 'TERM': 'linux', 08:23:44 INFO - 'TMOUT': '86400', 08:23:44 INFO - 'USER': 'cltbld', 08:23:44 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', 08:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:44 INFO - '_': '/tools/buildbot/bin/python'} 08:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:44 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 08:23:44 INFO - Cleaning up... 08:23:44 INFO - Return code: 0 08:23:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:44 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 0x7f47d47f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2f60>, '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 0xdc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc41d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', '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 08:23:44 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 08:23:44 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 08:23:44 INFO - Using env: {'DISPLAY': ':0', 08:23:44 INFO - 'HOME': '/home/cltbld', 08:23:44 INFO - 'LANG': 'en_US.UTF-8', 08:23:44 INFO - 'LANGUAGE': 'en_US:en', 08:23:44 INFO - 'LOGNAME': 'cltbld', 08:23:44 INFO - 'MAIL': '/var/mail/cltbld', 08:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:44 INFO - 'MOZ_NO_REMOTE': '1', 08:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:44 INFO - 'NO_EM_RESTART': '1', 08:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:44 INFO - 'PWD': '/builds/slave/test', 08:23:44 INFO - 'SHELL': '/bin/bash', 08:23:44 INFO - 'SHLVL': '1', 08:23:44 INFO - 'TERM': 'linux', 08:23:44 INFO - 'TMOUT': '86400', 08:23:44 INFO - 'USER': 'cltbld', 08:23:44 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', 08:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:44 INFO - '_': '/tools/buildbot/bin/python'} 08:23:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:45 INFO - Downloading/unpacking psutil>=3.1.1 08:23:45 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 08:23:45 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 08:23:45 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 08:23:45 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 08:23:45 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 08:23:45 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 08:23:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:23:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:47 INFO - Installing collected packages: psutil 08:23:47 INFO - Running setup.py install for psutil 08:23:47 INFO - building 'psutil._psutil_linux' extension 08:23:47 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 08:23:47 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 08:23:47 INFO - building 'psutil._psutil_posix' extension 08:23:47 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 08:23:48 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 08:23:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:48 INFO - Successfully installed psutil 08:23:48 INFO - Cleaning up... 08:23:48 INFO - Return code: 0 08:23:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:23:48 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')]} 08:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:48 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')]} 08:23:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:48 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 0x7f47d47f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2f60>, '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 0xdc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc41d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', '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 08:23:48 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 08:23:48 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 08:23:48 INFO - Using env: {'DISPLAY': ':0', 08:23:48 INFO - 'HOME': '/home/cltbld', 08:23:48 INFO - 'LANG': 'en_US.UTF-8', 08:23:48 INFO - 'LANGUAGE': 'en_US:en', 08:23:48 INFO - 'LOGNAME': 'cltbld', 08:23:48 INFO - 'MAIL': '/var/mail/cltbld', 08:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:48 INFO - 'MOZ_NO_REMOTE': '1', 08:23:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:48 INFO - 'NO_EM_RESTART': '1', 08:23:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:48 INFO - 'PWD': '/builds/slave/test', 08:23:48 INFO - 'SHELL': '/bin/bash', 08:23:48 INFO - 'SHLVL': '1', 08:23:48 INFO - 'TERM': 'linux', 08:23:48 INFO - 'TMOUT': '86400', 08:23:48 INFO - 'USER': 'cltbld', 08:23:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', 08:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:48 INFO - '_': '/tools/buildbot/bin/python'} 08:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:23:48 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 08:23:48 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 08:23:48 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 08:23:48 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 08:23:48 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 08:23:48 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 08:23:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:23:51 INFO - Installing collected packages: mozsystemmonitor 08:23:51 INFO - Running setup.py install for mozsystemmonitor 08:23:51 INFO - Successfully installed mozsystemmonitor 08:23:51 INFO - Cleaning up... 08:23:51 INFO - Return code: 0 08:23:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:23:51 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')]} 08:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:51 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')]} 08:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:51 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 0x7f47d47f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2f60>, '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 0xdc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc41d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', '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 08:23:51 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 08:23:51 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 08:23:51 INFO - Using env: {'DISPLAY': ':0', 08:23:51 INFO - 'HOME': '/home/cltbld', 08:23:51 INFO - 'LANG': 'en_US.UTF-8', 08:23:51 INFO - 'LANGUAGE': 'en_US:en', 08:23:51 INFO - 'LOGNAME': 'cltbld', 08:23:51 INFO - 'MAIL': '/var/mail/cltbld', 08:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:51 INFO - 'MOZ_NO_REMOTE': '1', 08:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:51 INFO - 'NO_EM_RESTART': '1', 08:23:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:51 INFO - 'PWD': '/builds/slave/test', 08:23:51 INFO - 'SHELL': '/bin/bash', 08:23:51 INFO - 'SHLVL': '1', 08:23:51 INFO - 'TERM': 'linux', 08:23:51 INFO - 'TMOUT': '86400', 08:23:51 INFO - 'USER': 'cltbld', 08:23:51 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', 08:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:51 INFO - '_': '/tools/buildbot/bin/python'} 08:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:51 INFO - Downloading/unpacking jsonschema==2.5.1 08:23:51 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 08:23:51 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 08:23:51 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 08:23:51 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 08:23:51 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 08:23:51 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 08:23:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:23:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:55 INFO - Downloading functools32-3.2.3-2.tar.gz 08:23:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:23:55 INFO - warning: no files found matching '*.txt' 08:23:55 INFO - no previously-included directories found matching 'build' 08:23:55 INFO - no previously-included directories found matching 'dist' 08:23:55 INFO - no previously-included directories found matching '.git*' 08:23:55 INFO - Installing collected packages: jsonschema, functools32 08:23:55 INFO - Running setup.py install for functools32 08:23:55 INFO - warning: no files found matching '*.txt' 08:23:55 INFO - no previously-included directories found matching 'build' 08:23:55 INFO - no previously-included directories found matching 'dist' 08:23:55 INFO - no previously-included directories found matching '.git*' 08:23:55 INFO - Successfully installed jsonschema functools32 08:23:55 INFO - Cleaning up... 08:23:55 INFO - Return code: 0 08:23:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:56 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 0x7f47d47f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2f60>, '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 0xdc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc41d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', '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 08:23:56 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 08:23:56 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 08:23:56 INFO - Using env: {'DISPLAY': ':0', 08:23:56 INFO - 'HOME': '/home/cltbld', 08:23:56 INFO - 'LANG': 'en_US.UTF-8', 08:23:56 INFO - 'LANGUAGE': 'en_US:en', 08:23:56 INFO - 'LOGNAME': 'cltbld', 08:23:56 INFO - 'MAIL': '/var/mail/cltbld', 08:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:56 INFO - 'MOZ_NO_REMOTE': '1', 08:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:56 INFO - 'NO_EM_RESTART': '1', 08:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:56 INFO - 'PWD': '/builds/slave/test', 08:23:56 INFO - 'SHELL': '/bin/bash', 08:23:56 INFO - 'SHLVL': '1', 08:23:56 INFO - 'TERM': 'linux', 08:23:56 INFO - 'TMOUT': '86400', 08:23:56 INFO - 'USER': 'cltbld', 08:23:56 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', 08:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:56 INFO - '_': '/tools/buildbot/bin/python'} 08:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:23:56 INFO - Cleaning up... 08:23:56 INFO - Return code: 0 08:23:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:56 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 0x7f47d47f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2f60>, '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 0xdc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc41d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', '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 08:23:56 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 08:23:56 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 08:23:56 INFO - Using env: {'DISPLAY': ':0', 08:23:56 INFO - 'HOME': '/home/cltbld', 08:23:56 INFO - 'LANG': 'en_US.UTF-8', 08:23:56 INFO - 'LANGUAGE': 'en_US:en', 08:23:56 INFO - 'LOGNAME': 'cltbld', 08:23:56 INFO - 'MAIL': '/var/mail/cltbld', 08:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:56 INFO - 'MOZ_NO_REMOTE': '1', 08:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:56 INFO - 'NO_EM_RESTART': '1', 08:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:56 INFO - 'PWD': '/builds/slave/test', 08:23:56 INFO - 'SHELL': '/bin/bash', 08:23:56 INFO - 'SHLVL': '1', 08:23:56 INFO - 'TERM': 'linux', 08:23:56 INFO - 'TMOUT': '86400', 08:23:56 INFO - 'USER': 'cltbld', 08:23:56 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', 08:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:56 INFO - '_': '/tools/buildbot/bin/python'} 08:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:56 INFO - Downloading/unpacking blobuploader==1.2.4 08:23:56 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 08:23:56 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 08:23:56 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 08:23:56 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 08:23:56 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 08:23:56 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 08:23:59 INFO - Downloading blobuploader-1.2.4.tar.gz 08:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:23:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:23:59 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 08:23:59 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 08:23:59 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 08:23:59 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 08:23:59 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 08:23:59 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 08:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:23:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:23:59 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 08:23:59 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 08:23:59 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 08:23:59 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 08:23:59 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 08:23:59 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 08:23:59 INFO - Downloading docopt-0.6.1.tar.gz 08:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:23:59 INFO - Installing collected packages: blobuploader, requests, docopt 08:23:59 INFO - Running setup.py install for blobuploader 08:24:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:24:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:24:00 INFO - Running setup.py install for requests 08:24:00 INFO - Running setup.py install for docopt 08:24:00 INFO - Successfully installed blobuploader requests docopt 08:24:00 INFO - Cleaning up... 08:24:00 INFO - Return code: 0 08:24:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24: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')]} 08:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24: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')]} 08:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:00 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 0x7f47d47f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2f60>, '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 0xdc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc41d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', '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 08:24:00 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 08:24:00 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 08:24:00 INFO - Using env: {'DISPLAY': ':0', 08:24:00 INFO - 'HOME': '/home/cltbld', 08:24:00 INFO - 'LANG': 'en_US.UTF-8', 08:24:00 INFO - 'LANGUAGE': 'en_US:en', 08:24:00 INFO - 'LOGNAME': 'cltbld', 08:24:00 INFO - 'MAIL': '/var/mail/cltbld', 08:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:00 INFO - 'MOZ_NO_REMOTE': '1', 08:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:00 INFO - 'NO_EM_RESTART': '1', 08:24:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:00 INFO - 'PWD': '/builds/slave/test', 08:24:00 INFO - 'SHELL': '/bin/bash', 08:24:00 INFO - 'SHLVL': '1', 08:24:00 INFO - 'TERM': 'linux', 08:24:00 INFO - 'TMOUT': '86400', 08:24:00 INFO - 'USER': 'cltbld', 08:24:00 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', 08:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:00 INFO - '_': '/tools/buildbot/bin/python'} 08:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:24:00 INFO - Running setup.py (path:/tmp/pip-J749sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:24:00 INFO - Running setup.py (path:/tmp/pip-fGy1oO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:24:00 INFO - Running setup.py (path:/tmp/pip-x2De5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:24:01 INFO - Running setup.py (path:/tmp/pip-JvMTJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:24:01 INFO - Running setup.py (path:/tmp/pip-v3frZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:24:01 INFO - Running setup.py (path:/tmp/pip-hR_Fwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:24:01 INFO - Running setup.py (path:/tmp/pip-6PHBnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:24:01 INFO - Running setup.py (path:/tmp/pip-qnERVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:24:01 INFO - Running setup.py (path:/tmp/pip-8Ff9Ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:24:01 INFO - Running setup.py (path:/tmp/pip-dJ3ToM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:24:01 INFO - Running setup.py (path:/tmp/pip-_whrZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:24:01 INFO - Running setup.py (path:/tmp/pip-oDqdVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:24:01 INFO - Running setup.py (path:/tmp/pip-3KBi4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:24:01 INFO - Running setup.py (path:/tmp/pip-on7uCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:01 INFO - Running setup.py (path:/tmp/pip-we_joV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:24:01 INFO - Running setup.py (path:/tmp/pip-IpMocv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:24:01 INFO - Running setup.py (path:/tmp/pip-GAWQZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:24:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:24:02 INFO - Running setup.py install for manifestparser 08:24:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:24:02 INFO - Running setup.py install for mozcrash 08:24:02 INFO - Running setup.py install for mozdebug 08:24:02 INFO - Running setup.py install for mozdevice 08:24:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:24:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:24:02 INFO - Running setup.py install for mozfile 08:24:02 INFO - Running setup.py install for mozhttpd 08:24:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:24:02 INFO - Running setup.py install for mozinfo 08:24:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:24:02 INFO - Running setup.py install for mozInstall 08:24:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:24:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:24:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:24:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:24:02 INFO - Running setup.py install for mozleak 08:24:02 INFO - Running setup.py install for mozlog 08:24:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:24:03 INFO - Running setup.py install for moznetwork 08:24:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:24:03 INFO - Running setup.py install for mozprocess 08:24:03 INFO - Running setup.py install for mozprofile 08:24:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:24:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:24:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:24:03 INFO - Running setup.py install for mozrunner 08:24:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:24:03 INFO - Running setup.py install for mozscreenshot 08:24:03 INFO - Running setup.py install for moztest 08:24:03 INFO - Running setup.py install for mozversion 08:24:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:24:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:24:03 INFO - Cleaning up... 08:24:03 INFO - Return code: 0 08:24:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24: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')]} 08:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24: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')]} 08:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:03 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 0x7f47d47f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2f60>, '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 0xdc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc41d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', '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 08:24:03 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 08:24:03 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 08:24:03 INFO - Using env: {'DISPLAY': ':0', 08:24:03 INFO - 'HOME': '/home/cltbld', 08:24:03 INFO - 'LANG': 'en_US.UTF-8', 08:24:03 INFO - 'LANGUAGE': 'en_US:en', 08:24:03 INFO - 'LOGNAME': 'cltbld', 08:24:03 INFO - 'MAIL': '/var/mail/cltbld', 08:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:03 INFO - 'MOZ_NO_REMOTE': '1', 08:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:03 INFO - 'NO_EM_RESTART': '1', 08:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:03 INFO - 'PWD': '/builds/slave/test', 08:24:03 INFO - 'SHELL': '/bin/bash', 08:24:03 INFO - 'SHLVL': '1', 08:24:03 INFO - 'TERM': 'linux', 08:24:03 INFO - 'TMOUT': '86400', 08:24:03 INFO - 'USER': 'cltbld', 08:24:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', 08:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:03 INFO - '_': '/tools/buildbot/bin/python'} 08:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:24:04 INFO - Running setup.py (path:/tmp/pip-ILIJBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:24:04 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)) 08:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:24:04 INFO - Running setup.py (path:/tmp/pip-9W5feo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:24:04 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)) 08:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:24:04 INFO - Running setup.py (path:/tmp/pip-kiKwFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:24:04 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)) 08:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:24:04 INFO - Running setup.py (path:/tmp/pip-KdNSpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:24:04 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)) 08:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:24:04 INFO - Running setup.py (path:/tmp/pip-3C5wc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:24:04 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)) 08:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:24:04 INFO - Running setup.py (path:/tmp/pip-yy45jM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:24:04 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)) 08:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:24:04 INFO - Running setup.py (path:/tmp/pip-wWsjL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:24:04 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)) 08:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:24:04 INFO - Running setup.py (path:/tmp/pip-UyU5VX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:24:04 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)) 08:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:24:04 INFO - Running setup.py (path:/tmp/pip-Lr0ONl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:24:04 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)) 08:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:24:04 INFO - Running setup.py (path:/tmp/pip-jPsfxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:24:04 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)) 08:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:24:04 INFO - Running setup.py (path:/tmp/pip-r8YPpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:24:04 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)) 08:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:24:04 INFO - Running setup.py (path:/tmp/pip-KRDUJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:24:04 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)) 08:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:24:04 INFO - Running setup.py (path:/tmp/pip-WLjinb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:24:05 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)) 08:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:24:05 INFO - Running setup.py (path:/tmp/pip-rJKyMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:24:05 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)) 08:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:05 INFO - Running setup.py (path:/tmp/pip-fVTmiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:05 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)) 08:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:24:05 INFO - Running setup.py (path:/tmp/pip-cEAli9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:24:05 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)) 08:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:24:05 INFO - Running setup.py (path:/tmp/pip-ybaNIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:24:05 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)) 08:24:05 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)) 08:24:05 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)) 08:24:05 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)) 08:24:05 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)) 08:24:05 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)) 08:24:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:07 INFO - Downloading blessings-1.6.tar.gz 08:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:24:07 INFO - Installing collected packages: blessings 08:24:07 INFO - Running setup.py install for blessings 08:24:07 INFO - Successfully installed blessings 08:24:07 INFO - Cleaning up... 08:24:07 INFO - Return code: 0 08:24:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:24:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:24:07 INFO - Reading from file tmpfile_stdout 08:24:07 INFO - Current package versions: 08:24:07 INFO - argparse == 1.2.1 08:24:07 INFO - blessings == 1.6 08:24:07 INFO - blobuploader == 1.2.4 08:24:07 INFO - docopt == 0.6.1 08:24:07 INFO - functools32 == 3.2.3-2 08:24:07 INFO - jsonschema == 2.5.1 08:24:07 INFO - manifestparser == 1.1 08:24:07 INFO - mozInstall == 1.12 08:24:07 INFO - mozcrash == 1.0 08:24:07 INFO - mozdebug == 0.1 08:24:07 INFO - mozdevice == 0.48 08:24:07 INFO - mozfile == 1.2 08:24:07 INFO - mozhttpd == 0.7 08:24:07 INFO - mozinfo == 0.9 08:24:07 INFO - mozleak == 0.1 08:24:07 INFO - mozlog == 3.4 08:24:07 INFO - moznetwork == 0.27 08:24:07 INFO - mozprocess == 0.23 08:24:07 INFO - mozprofile == 0.28 08:24:07 INFO - mozrunner == 6.13 08:24:07 INFO - mozscreenshot == 0.1 08:24:07 INFO - mozsystemmonitor == 0.3 08:24:07 INFO - moztest == 0.8 08:24:07 INFO - mozversion == 1.4 08:24:07 INFO - psutil == 3.1.1 08:24:07 INFO - requests == 1.2.3 08:24:07 INFO - wsgiref == 0.1.2 08:24:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:07 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 0x7f47d47f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2f60>, '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 0xdc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc41d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', '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 08:24:07 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 08:24:08 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 08:24:08 INFO - Using env: {'DISPLAY': ':0', 08:24:08 INFO - 'HOME': '/home/cltbld', 08:24:08 INFO - 'LANG': 'en_US.UTF-8', 08:24:08 INFO - 'LANGUAGE': 'en_US:en', 08:24:08 INFO - 'LOGNAME': 'cltbld', 08:24:08 INFO - 'MAIL': '/var/mail/cltbld', 08:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:08 INFO - 'MOZ_NO_REMOTE': '1', 08:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:08 INFO - 'NO_EM_RESTART': '1', 08:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:08 INFO - 'PWD': '/builds/slave/test', 08:24:08 INFO - 'SHELL': '/bin/bash', 08:24:08 INFO - 'SHLVL': '1', 08:24:08 INFO - 'TERM': 'linux', 08:24:08 INFO - 'TMOUT': '86400', 08:24:08 INFO - 'USER': 'cltbld', 08:24:08 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', 08:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:08 INFO - '_': '/tools/buildbot/bin/python'} 08:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:08 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)) 08:24:08 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)) 08:24:08 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)) 08:24:08 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)) 08:24:08 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)) 08:24:08 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)) 08:24:08 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)) 08:24:08 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)) 08:24:08 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)) 08:24:08 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)) 08:24:08 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)) 08:24:08 INFO - Cleaning up... 08:24:08 INFO - Return code: 0 08:24:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:24: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')]} 08:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24: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')]} 08:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f47d47f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2f60>, '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 0xdc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc41d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', '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 08:24: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', 'jsonschema'] in /builds/slave/test/build 08:24: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 jsonschema 08:24:08 INFO - Using env: {'DISPLAY': ':0', 08:24:08 INFO - 'HOME': '/home/cltbld', 08:24:08 INFO - 'LANG': 'en_US.UTF-8', 08:24:08 INFO - 'LANGUAGE': 'en_US:en', 08:24:08 INFO - 'LOGNAME': 'cltbld', 08:24:08 INFO - 'MAIL': '/var/mail/cltbld', 08:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:08 INFO - 'MOZ_NO_REMOTE': '1', 08:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:08 INFO - 'NO_EM_RESTART': '1', 08:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:08 INFO - 'PWD': '/builds/slave/test', 08:24:08 INFO - 'SHELL': '/bin/bash', 08:24:08 INFO - 'SHLVL': '1', 08:24:08 INFO - 'TERM': 'linux', 08:24:08 INFO - 'TMOUT': '86400', 08:24:08 INFO - 'USER': 'cltbld', 08:24:08 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', 08:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:08 INFO - '_': '/tools/buildbot/bin/python'} 08:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:24:08 INFO - Cleaning up... 08:24:08 INFO - Return code: 0 08:24:08 INFO - Running post-action listener: _resource_record_post_action 08:24:08 INFO - Running post-action listener: _start_resource_monitoring 08:24:08 INFO - Starting resource monitoring. 08:24:08 INFO - [mozharness: 2017-01-06 16:24:08.480821Z] Finished create-virtualenv step (success) 08:24:08 INFO - [mozharness: 2017-01-06 16:24:08.481324Z] Running install step. 08:24:08 INFO - Running pre-action listener: _resource_record_pre_action 08:24:08 INFO - Running main action method: install 08:24:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:24:08 INFO - Reading from file tmpfile_stdout 08:24:08 INFO - Detecting whether we're running mozinstall >=1.0... 08:24:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:24:08 INFO - Reading from file tmpfile_stdout 08:24:08 INFO - Output received: 08:24:08 INFO - Usage: mozinstall [options] installer 08:24:08 INFO - Options: 08:24:08 INFO - -h, --help show this help message and exit 08:24:08 INFO - -d DEST, --destination=DEST 08:24:08 INFO - Directory to install application into. [default: 08:24:08 INFO - "/builds/slave/test"] 08:24:08 INFO - --app=APP Application being installed. [default: firefox] 08:24:08 INFO - mkdir: /builds/slave/test/build/application 08:24:08 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'] 08:24:08 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 08:24:24 INFO - Reading from file tmpfile_stdout 08:24:24 INFO - Output received: 08:24:24 INFO - /builds/slave/test/build/application/firefox/firefox 08:24:24 INFO - Running post-action listener: _resource_record_post_action 08:24:24 INFO - [mozharness: 2017-01-06 16:24:24.715875Z] Finished install step (success) 08:24:24 INFO - [mozharness: 2017-01-06 16:24:24.716084Z] Running run-tests step. 08:24:24 INFO - Running pre-action listener: _resource_record_pre_action 08:24:24 INFO - Running main action method: run_tests 08:24:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:24:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:24:24 INFO - Python 2.7.3 08:24:24 INFO - Return code: 0 08:24:24 INFO - grabbing minidump binary from tooltool 08:24:24 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')]} 08:24:24 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 0xdc2f60>, '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 0xdc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc41d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:24:24 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 08:24:24 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 08:24:24 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 08:24:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:24:24 INFO - Return code: 0 08:24:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:24:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:24:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:24:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:24:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:24:24 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:24:24 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:24:24 INFO - Using env: {'DISPLAY': ':0', 08:24:24 INFO - 'HOME': '/home/cltbld', 08:24:24 INFO - 'LANG': 'en_US.UTF-8', 08:24:24 INFO - 'LANGUAGE': 'en_US:en', 08:24:24 INFO - 'LOGNAME': 'cltbld', 08:24:24 INFO - 'MAIL': '/var/mail/cltbld', 08:24:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:24:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:24 INFO - 'MOZ_NO_REMOTE': '1', 08:24:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:24:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:24 INFO - 'NO_EM_RESTART': '1', 08:24:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:24 INFO - 'PWD': '/builds/slave/test', 08:24:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:24:24 INFO - 'SHELL': '/bin/bash', 08:24:24 INFO - 'SHLVL': '1', 08:24:24 INFO - 'TERM': 'linux', 08:24:24 INFO - 'TMOUT': '86400', 08:24:24 INFO - 'USER': 'cltbld', 08:24:24 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413', 08:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:24 INFO - '_': '/tools/buildbot/bin/python'} 08:24:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:24:24 INFO - mozversion application_buildid: 20170106063601 08:24:24 INFO - mozversion application_changeset: 0c3414e6f0b2535f7b7668e835fbfe2401c43bb0 08:24:24 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:24:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:24:24 INFO - mozversion application_name: Firefox 08:24:24 INFO - mozversion application_remotingname: firefox-dev 08:24:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:24:24 INFO - mozversion application_vendor: Mozilla 08:24:24 INFO - mozversion application_version: 52.0a2 08:24:24 INFO - mozversion platform_buildid: 20170106063601 08:24:24 INFO - mozversion platform_changeset: 0c3414e6f0b2535f7b7668e835fbfe2401c43bb0 08:24:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:24:24 INFO - mozversion platform_version: 52.0a2 08:24:24 INFO - using testdate: 1483719864 08:24:24 INFO - actual date: 1483719864 08:24:24 INFO - starting webserver on 'localhost:42167' 08:24:24 INFO - SUITE-START | Running 2 tests 08:24:24 INFO - TEST-START | dromaeo_css 08:24:24 INFO - operating with platform_type : linux_ 08:24:24 INFO - Initialising browser for dromaeo_css test... 08:24:25 INFO - TEST-INFO | started process 11269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Xk4fn/profile http://localhost:42167/getInfo.html) 08:24:29 INFO - PROCESS | 11269 | __metrics Screen width/height:1600/1200 08:24:29 INFO - PROCESS | 11269 | colorDepth:24 08:24:29 INFO - PROCESS | 11269 | Browser inner width/height: 1024/697 08:24:29 INFO - PROCESS | 11269 | __metrics 08:24:29 INFO - PROCESS | 11269 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:24:29 INFO - PROCESS | 11269 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:24:30 INFO - PROCESS | 11269 | console.error: PushService: 08:24:30 INFO - PROCESS | 11269 | stateChangeProcessEnqueue: Error transitioning state 08:24:30 INFO - PROCESS | 11269 | UnknownError 08:24:30 INFO - TEST-INFO | 11269: exit 0 08:24:30 INFO - Browser initialized. 08:24:30 INFO - Running cycle 1/1 for dromaeo_css test... 08:24:30 INFO - TEST-INFO | started process 11360 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Xk4fn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:42 INFO - PROCESS | 11360 | RSS: Main: 144814080 08:24:42 INFO - PROCESS | 11360 | 08:27:44 INFO - PROCESS | 11360 | Cycle 1(1): loaded http://localhost:42167/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42167/tests/dromaeo/cssquery-ext.html) 08:27:45 INFO - PROCESS | 11360 | RSS: Main: 238592000 08:27:45 INFO - PROCESS | 11360 | 08:30:47 INFO - PROCESS | 11360 | Cycle 1(1): loaded http://localhost:42167/tests/dromaeo/cssquery-ext.html (next: http://localhost:42167/tests/dromaeo/cssquery-jquery.html) 08:30:48 INFO - PROCESS | 11360 | RSS: Main: 233799680 08:30:48 INFO - PROCESS | 11360 | 08:33:50 INFO - PROCESS | 11360 | Cycle 1(1): loaded http://localhost:42167/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42167/tests/dromaeo/cssquery-mootools.html) 08:33:51 INFO - PROCESS | 11360 | RSS: Main: 173887488 08:33:51 INFO - PROCESS | 11360 | 08:36:52 INFO - PROCESS | 11360 | Cycle 1(1): loaded http://localhost:42167/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42167/tests/dromaeo/cssquery-prototype.html) 08:36:53 INFO - PROCESS | 11360 | RSS: Main: 175632384 08:36:53 INFO - PROCESS | 11360 | 08:39:56 INFO - PROCESS | 11360 | Cycle 1(1): loaded http://localhost:42167/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42167/tests/dromaeo/cssquery-yui.html) 08:39:56 INFO - PROCESS | 11360 | RSS: Main: 177131520 08:39:56 INFO - PROCESS | 11360 | 08:42:59 INFO - PROCESS | 11360 | Cycle 1(1): loaded http://localhost:42167/tests/dromaeo/cssquery-yui.html (next: http://localhost:42167/tests/dromaeo/cssquery-dojo.html) 08:42:59 INFO - PROCESS | 11360 | RSS: Main: 263733248 08:42:59 INFO - PROCESS | 11360 | 08:42:59 INFO - PROCESS | 11360 | __start_tp_report 08:42:59 INFO - PROCESS | 11360 | _x_x_mozilla_page_load 08:42:59 INFO - PROCESS | 11360 | _x_x_mozilla_page_load_details 08:42:59 INFO - PROCESS | 11360 | |i|pagename|runs| 08:42:59 INFO - PROCESS | 11360 | |0;dojo.html;3217.260030193055;3260.527223552584;3265.983670081649;3284.261041265717;3304.322613864158;5495.862603434911;5588.441155884409;5609.3268807743125;5618.381977982423;5628.155776633507;5570.275864137657;5629;5637.210790489325;5655.123455864337;5667.263255776754;5079.64442489025;5102.566281866046;5123.5901127909865;5123.615728820335;5173.689578625275;5011.298418221452;5178.818741344054;5184.611154163453;5205.427402985688;5208.348956380452;5011.849644510652;5063.84808455745;5117.641765076446;5119.718415487147;5123.846284611449;5178.5339319461245;5193.091209038422;5255.632105752599;5263.736813159365;5279.524842764131;4928.383952005999;4932.605391568666;5148.382194136728;5167.379914410295;5228.895422091537;5475.0418676731815;5480.80817171401;5496.31296087989;5554.694491802949;5592;5921;6008;6042.456178943916;6050.606710563799;6054.152418661391;5891.617044892068;5959.195508606326;6067.211262535842;6092.299385570627;6112.510999120104;5538.030844602178;5569.721513924287;5578.023845826964;5618.85952851182;5626.578006649435;6125.724342404603;6135.785247516315;6142;6150.354212807681;6156.045812899008;5725.141228815628;5774.769009239667;5889.764409423661;5896.587238893237;5897.557683173779;5936.851578710567;5986.431289027535;6017.789377371771;6078.240219972504;6109.450149486479;6031.306399764083;6048.0625503047095;6049.425304596057;6061.636301821904;6086.573939824259;5808.564357673192;5992.610480318765;6042.003069493572;6057.575969682168;6068.635881847015;4583.770811459413;4618.838340658128;4619.353290539327;4642.46611639659;4650.976745116321;4133.751974881517;4140.420341152241;4142.855000074983;4161.396597493346;4167.2082304362075;5796.449337312949;5802;5802.245708057925;5813.389594092644;5821.941780582225;5664.291963504562;5697.515711164515;5739.282589676291;5956.85107872298;6053.303870055;5698.886022279531;5768.913466298009;5779.595428319977;5786.913196302059;5802.796902108406;5191.351081114861;5230.529252367305;5247.422783493813;5249.685018898878;5253.816116435906;6054.7275372607455;6313.873722525524;6333.524985626096;6333.714982825692;6341.048842673636;5843.766249349978;6010.489108425658;6025.216721826135;6030.03519436888;6124.295705993868;6322.873542529215;6332.746690132343;6354.23749150105;6364.809055728336;6365.3316401779;5890.957579134906;5943;5949.881002380015;5960.523158147251;5964.075568286922;5752.539796816328;5810.738516766671;6060.303065147565;6079.05774604937;6106.084087386927;6049.939500604937;6052.546059045501;6065.757369705162;6068.787592434243;6077.817665470043;6000.939990600213;6013.939860601338;6025.427584379477;6025.638461692312;6035.124906888389;5590.077637189981;5677.801276955452;5716.371199168005;5721.399253078367;5987.940120598738;5870.14882841994;5879.882402351844;5879.911801322898;5881.353051164283;5914.674692891932;5407.432219616883;5571.498565129158;5618.85952851182;5623.550115990793;5629.690367029689 08:42:59 INFO - PROCESS | 11360 | |1;ext.html;571.7370009795494;599.5653151465189;618.1130078337587;627.2535682537776;647.8963365861463;35578.82210588946;45070.549294507044;45811.31283030749;45897.7705111474;45965.77017114918;47471.52528474714;47874.76062619682;47927.760361198234;47964.52035479644;47994;8456.281216096608;8790.91209087909;8908.064653211417;8915.063918288584;8946.194842464178;8370.53962032088;8564.229219370256;8568.571571421404;10487.842682359733;10771.730706732316;10936.070434013118;10991.505382257777;10996.725081872937;11008.669739907775;11014.834777478345;10800.5679772809;10847.403392813392;10873.945630271837;10875.238733288674;10876.836847447215;10535.525901334458;10590.523426445829;10602.681919542427;10606.840897386546;10608.416537090457;44102;44267.33598996018;44425.55574444246;44430.33354499653;44462.77768611169;3475.4439289713778;3492.842822073013;3596.856125754967;3605.8918232452806;3618.9095272618133;30985.070447886374;31059;31069;31219.84390078058;31807.363852723047;4010.859619913289;4144.626983571463;4191.392248124035;4192.24539582875;4268.9573104268875;339111;340190;340858;340879.29560352286;342221;60438.39561604416;60685;60731.69634151801;60809.695951519956;60937.08594371088;38969.41545876814;39726.801365992986;39905;41397.37903931444;41429.58570414257;18676.159572819255;18872;18887.622247554973;18893.527661808566;18900;12665.176763510342;14525.491607793676;14550;14684.559463216121;14691;17848.37530686446;19456.07629833848;20802.375928722162;20948.790512094685;20973.895130524554;7503.585868429851;7669.808254793563;7675.424343174284;7698.692052317844;7712.534618422482;1011.261778901406;1011.9342242754344;1051.4690081508788;1056.7041228456044;1139.0602752729033;32751.836240818644;32757.181070473427;32962.50556241658;33584.83207583995;34005.31989360199;1076.9730756731144;1191.6186820217447;1268.2390565660714;1286.1382873474795;1298.6558561981083;16853.241604127845;17551.912240438716;17725.29098836032;17792.288308467774;17863.28546858111;511753;514717;515549;515640;516493;62125.37874621286;62676.373236267056;62844.05733913995;62878.371216288164;62924.68537657282;1345.159275452842;1389.5831250624772;1401.663600735816;1452.8765054970233;1463.9853601464063;32845.34309313848;34729.47905781466;34870.30259394849;35114.64885351216;35235.95999340806;52289.477105229984;52988.73505632447;53036.73481632567;53101;53113.46886531085;384371;385526;386253;386937;388462;29925.251868703457;31603.36793264168;31652.683473164972;31974.200644984063;32587.837060814545;47843.76078119587;49625.503744963535;49712;50400.49599503958;50898.74550627223;41857.162856742085;42279.577204227564;42926.35610465908;43027.35458968055;43034.35448468213;41365.793171033954;41719;41910.580894190665;42725.1454970905;43733.56266437295;42022.78988605038;43497;43525.91185220395;44169.77915110404;44255.557444426435;31228.947407818116;33416.82540158681;33515.83242083774;33583;33591.49612755762;24590.754092459563;24606.876965615058;24719.38201544904;25067;25076.373090672878 08:42:59 INFO - PROCESS | 11360 | |2;jquery.html;389.9025243689078;424.0703074030012;426.7823410060869;440.3504830375195;440.57484527431023;16135;19029.143688534015;20305.086271117798;20534.38396848093;20547.280845170404;19944.700829487534;20149.19403223873;20273.69589456159;20349.796502034977;20509.897450512726;5625.1843482695085;5857.736401861926;5858.091995740646;5867.413258674141;5867.735951882154;5533.889322213553;5773.826785196451;5796.971015144918;5800.9129863052085;5804.303483581976;5679.062954612484;5761.9135712964335;5763.596548241604;5764.394738552454;5766.0486019806685;5661.207430959669;5668.404817494165;5724.341700704431;5754.338251101114;5785.566082543805;5146.459621739701;5148.897022059576;5185.248139019821;5194.6104042196985;5204.609654275944;23787.64318535206;23896.522069558512;23970.161044363365;24011.51976960451;24133;2258.9322320330416;2350.4476448034698;2418.6734790803193;2730.30377253799;2795.5247607906704;14132.36404361796;14312.64218394538;14397.13617182962;14654.633634159125;15278.923605381902;1788.1416919878402;1871.1579789094963;1880.7366968624403;1893.9715904261448;1908.8568357373254;84838;88806.5559672204;93644;105492;106450.46774766155;14768.609457548133;17399.91300043517;18017.2793088275;18059.729104063448;18998.43004709861;30850;33819.66180338214;33882;34019.659803402144;34050.48924266138;10656.655535782116;10851.67444976652;10916.617918372818;10990.230683852054;11147.498362573542;8674.56627168639;8757.430767000253;8798.956005220061;8870.778230544289;9031.729048128567;9130.223930965942;9306.162445379949;9321.44071355721;9490;9583.233341332816;3422.743294252941;3440.9655903440644;3707.981460092736;3780.584135745121;3781.357169281174;1046.4819914142547;1057.799018186542;1071.3250652089134;1078.983815242772;1079.7624522605015;18518;19168;20363.18547258093;20452.181912723623;20793.58412831735;1034.1984961654778;1045.8274384726435;1080.8324709670014;1106.7343837478948;1110.2006555280186;10809.459527023617;11233.719157020976;11283.887161128283;11364.715882103013;11421.314721116594;173246;173293;173432;174062;427864;93572.53213734024;93622.06377936133;95645.52177239208;96381;97641;1048.1771809129796;1069.8716154061563;1103.382106020631;1107.6044184327804;1108.2187058124002;17817.73273400926;17949.910250449186;18379.17293721759;18424.35514756977;18491.722624160917;31698.207544811565;35218.64781352154;39956;40015.79992100137;42695.5730442704;56106.43893561175;56432.43567564436;56993.43006569881;57653.13520297115;58070.4192958065;8687.409113243059;8944.910550894409;8977.955110224408;8979.730608081769;9025.052369501107;12060.336681482602;13328.333583320602;13385.19688818674;13467.528636497676;13525.729485410433;11906.404679765803;12015;12049.457774400349;12302.138850280395;12719.173253738478;11409.144314176305;11681.532738690697;11740.58907938218;11763.353015583883;12051.57819476314;12101.939490302844;12170;12338.629841104781;12465.813012804634;12480.56318028901;8175.67297308101;8789.560521974003;8799.648014079621;8993.910060899569;9072.863907041532;11917.82123268169;12098.213616114925;12240.326782027074;12296.692582685504;12447.253164810141 08:42:59 INFO - PROCESS | 11360 | |3;mootools.html;1542.6474626195052;1554.471479696903;1747.7291019891913;1825.2425243523937;1859.2191279662532;8296.875546866795;8831.91168088319;8850.026497085315;8852.822943541125;8853.911460885389;7853.332466740334;8114.634841432135;8369.372297077713;8463.830723385528;8729.694460693878;2420.4553975355534;2477.8513289202615;2486.639437281593;2488.340589743719;2490.8007359411204;2409.5421869844763;2536.936576585582;2555.706093799209;2557.884895179712;2559.398541342783;2368.7039120109985;2391.234804862445;2409.8915548800346;2454.5704501712216;2481.0695989004125;2408.722996855358;2408.976185121325;2427.1990243219693;2430.805535557151;2435.6346548017764;2431.7203521595065;2433.197044975154;2458.2870967419426;2460.7047154341412;2467.383154211447;8878.600462979117;8931;8992.595333210022;9003.234725048378;9023.233025192802;5477.3427188737205;5616.719164041822;5618.297712785902;5621.437856214346;5625.6905870177125;3420.675035871588;3433.4506478963494;3504.281622267429;3580.9283814323826;3586.103474131467;1125.8536390269212;1145.8223975283845;1168.5442677355838;1178.3401295274673;1187.780260651782;12287.754244915051;12486.75026499474;12544.560940367044;12628.747425051448;12636.936815315865;4768.47546769855;4946.9010619787405;5018.799248030111;5038.067957427887;5094.439611642716;10669.89330106689;10679.57281708723;10679.78640427187;10693.893061069446;10711.89288107109;5755.424457554295;5768.307803063659;5770.826875193751;5781.682007489629;5782.942170578324;4519.231730605805;4800.183968725325;4992.900141997213;5030.899382012412;5196.32447781786;4211.7262377945335;4264.829406823755;4322.222000040023;4346.195953748504;4366.104948485553;1361.4418088583832;1410.9223992680295;1414.6746248362933;1416.7803990381508;1432.298173894784;807.0937207910678;928.758522784081;945.6879229854131;966.6230170233614;1000.4297550396204;5903.970480147572;5946.256717910262;6124.173236613089;6255;6303.117563541108;969.2149359019216;978.5058545434653;987.9259055570861;1005.1757558801859;1025.5231317437429;4059.2084543513733;4271.914561708811;4317.41714868495;4322.265214913409;4438.267685831866;10423;10980.396078215615;10984.615538456115;10995.835062474069;11054.557817687364;10900.34597924127;10905.781884362426;10913;10914.672559823219;10924.508397122148;7959.363250939911;8298.419110662317;8307.335413166933;8341.582920853933;8473.195046470699;5823.417658234142;6040.335563088145;6045.486133678686;6218.533609979179;6265.906011409924;10277.537510811882;10285.691429257135;10286.845697314397;10292.948535257276;10335.793284134124;9711.9028809711;10105.494725263854;10120.696379108638;10232.53953572106;10321.48392580383;7934.60326983637;8079.434439589408;8093.231143041402;8100.594970251346;8109.270165685117;8267.710630127916;8459.154084591491;8500.362472814688;8544.145585441405;8552.401331906956;7368.668409921459;7524.887126692995;7535.773926782205;7718.884216736641;7722.691092356243;7048.154221493453;7103.396211322096;7600;7741;7813.492123011986;7263.491555591269;7278.09023872016;7281.417486601165;7293;7333.303336183054;5150.278960945546;5246.3704355477585;5252.789888404421;5360.973195133999;5443.455654434525;5223.634345595772;5248.606354523502;5259.973700131475;5333.5199832015305;5350.6254562180275 08:42:59 INFO - PROCESS | 11360 | |4;prototype.html;347.9878204262851;351.99648003519957;353.27225914615894;355.7598620930871;357.8425492783175;5347.224652425396;5372.382176049756;5372.615252390998;5401.3248343957;5450.482204190605;5344.679319240849;5346.743515273917;5372.597055220865;5402.756875940582;5418.2685337479425;3753;4037.4953130858644;4105.958940410587;4137.379393091045;4240.045989652334;4227.450431443908;4232.619064284214;4242.80907359168;4250.48994120706;4254.468191476066;4225.429567008446;4225.556316586761;4244.236037513247;4252.19208350414;4255.4467919170465;4054.8574854487715;4063.553009168989;4082.8571000015154;4250.893727656802;4271.63691086258;3730.645588669072;3730.8880733578035;3732.9361132077497;3754.530683664542;3769.6230376962358;5205.817796377109;5216.061109000379;5227.785655795016;5240.3187585614005;5263.86840328991;4726.558399688094;4738.218193997986;4811.13399588074;4832.516748325174;4840.443349014838;5551.306086739158;5552.944470555323;5560.165145501975;5566.916496252559;5579.330480342344;4113.650339721127;4122.484689413824;4127.545969943304;4144.129732756125;4156.646685031776;5662.943370566283;5777.913331299992;5850.9414905851245;5876.236089308405;5938.703064846741;4191.371294305817;4208.85269015583;4219.451471308772;4222.9577704223175;4237.915241695149;4248.277792775236;4251.192273468031;4256.765877876746;4262.552431994658;4296.183725092223;4703.882402939954;4826.831060912851;4837.612990960714;4846.36997190363;4851.442084160296;5577;5579.944200558024;5614.719264036864;5616.634918730269;5641.464060914206;1422.4381369359046;1422.8292604887272;1425.978610320846;1431.5848403962943;1441.466657336771;972.4602845420859;1007.1791489935679;1014.5637375928274;1017.4454922067491;1038.0346277961416;5336.706481143575;5354.7951710864745;5365.570754339644;5390.21841832932;5403.486668766461;5577.358603760619;5592.8042518512475;5594.608377413542;5597.636153650081;5614.410486898899;5269.762860671279;5329.360476742738;5382.219578161144;5540.612157148961;5546.27898373217;2960.3487232808748;2963.748081413104;2975.642922849229;2980.4203772000874;2984.552317152401;5602.851415459821;5848.3274423441;5848.970755146197;5861.596745334393;5886.676232807236;5619.381867994517;5756.481916627524;5761.39505351932;5763.827085187451;5774.82675519735;5840.445157710011;5852.970735146297;6012.368701286302;6041.758329666764;6081.39186081406;5843;5845.311156867719;5845.41545845412;5852.18069470266;5860;5600.4959553640365;5724.656520608777;5729.799457018984;5778.624389414675;5796.478316951495;5983.521318294439;6020;6037.63774173551;6054.90917636227;6064.332923378337;4206.537280899038;4221.662267018693;4240.4487416636875;4263.701540892108;4278.67909906752;5631.802886898939;5804.216430781959;5807.651540907559;5808.601967848686;5832.912506312324;5680.573956953328;5688.943110568841;5691.686957217393;5693.4875861172695;5701.40135285789;5535.418781027934;5619.747111379916;5654.943450565442;5706.629069110494;5717.628354156966;5588.86027849307;5606.6636001840025;5616.634918730269;5636.661800291996;5652.463016013472;5649.830505084854;5677.545796336366;5693.259876216065;5700.287464066992;5700.543956483554;5266.578673706018;5383.7846486140115;5401.621886468067;5409.78360865561;5417.620766546462 08:42:59 INFO - PROCESS | 11360 | |5;yui.html;705.2841366013497;715.5384776818951;720.5208536323345;734.2767374136474;756.1077928044912;15170.84829151708;15879.52361429156;15889.602759931007;15911.522654320375;15978.600534986632;13491.988100892424;13506;13549.729005419911;13553.661158471019;13553.661158471043;717.6842189436632;735.1435577552145;835.853725598018;857.2113655436997;860.6127242740761;869.3393021303823;871.1897934920521;872.0233338660709;872.0538216035609;874.6064271078009;915.771057235691;916.7983043730369;917.3028498341242;918.7335672654956;919.3059240273584;748.1022772672815;765.6248438265238;876.7457437343163;897.2821742605889;910.717677519971;669.009865399207;670.3464122480591;672.5225090185974;672.6065251827687;673.0241150332038;14458.493952711604;14911.105333680014;14947.551573452814;14959.326830292553;14963.551093467104;12676;12984.740305193938;13075.86924130756;13156.342182890912;13188;11204.271722338022;11367.886321136766;11530.42347882611;11568.363739994296;11790.88209117915;3501.842417091237;3615.511905892697;3984.1035766952496;4037.3338399164104;4149.481314835645;63591.68204158996;64142.3585764141;64829.67585162091;65017.67491162514;66601;10221.824490183724;10223;10231.56758053873;10404.063634272952;10421.114205292484;19750.209991600175;19811.504712382306;19824.107915143853;19842.007899604963;20084;7764.961175194087;7968.282854543003;8013.719519816778;8038.839223215503;8110.472819266847;4407.118576284756;4420.689827418241;4486.013077123028;4666.300054991711;4743.359646447685;3592.0660628236847;3657.8902632921054;3688.7786732796117;3731.2910546995986;3737.9252414951548;618.4032408725601;631.5389765471232;645.493287769099;659.8518577674907;662.6189940783972;623.4513628007415;714.1786945013276;720.5964659790534;745.9142198647116;752.5183882315323;8918.777030574158;9057.637694492278;9118.726438206864;9775.51122443875;10057.647982320585;691.4295706042535;706.5584009993754;756.5196100476127;768.1511929318135;818.7257268815014;4182.435371224907;4673.742944138037;4726.598239149642;4824.565789079;4858.562729354305;84941.57529212315;85760;88031.55984220038;89377;90458.54770726104;70536.64731676309;76147.61926190334;76406.23593764102;76569;78067.60966195133;70569.99999999897;71572;72623.91064134042;72652.54694906178;73875.63062184762;8521.957390213009;8704.91295087041;8706.3034957202;8783.341249406192;8803.471791692518;45052.774736126106;45176.09647807091;45990.310145348514;46145.76927115343;46559;56660.43339566716;58531;61454.38545614666;64410.355896442314;65429.672851635434;11525.769484610428;11673.241239319417;11788.528458861892;11908.821367679318;11945.4027298633;12913.09608327408;13026.47894084226;13209.471621135432;13226.206427614374;13274.137181083199;11540.711482213012;12113.75772484563;12186.268823870241;12286.692832679255;12409.255444673348;12860.2926839021;12881.48474061027;13107.213567186;13181.934090329487;13226.206427614374;12391.380430978235;12505.249685018563;12730;13035.934820325838;13182.60452186436;9826.213902887608;10240.48797560134;10243.94878025605;10370.42962637032;10503.002214789583;10897.291676041032;10946.288491248044;11009.174311926477;11186.161037922026;11297.943510282395 08:42:59 INFO - PROCESS | 11360 | __end_tp_report 08:42:59 INFO - PROCESS | 11360 | __start_cc_report 08:42:59 INFO - PROCESS | 11360 | _x_x_mozilla_cycle_collect,1002 08:42:59 INFO - PROCESS | 11360 | __end_cc_report 08:42:59 INFO - PROCESS | 11360 | __startTimestamp1483720979410__endTimestamp 08:42:59 INFO - PROCESS | 11360 | 08:42:59 INFO - PROCESS | 11360 | ------- Summary: start ------- 08:42:59 INFO - PROCESS | 11360 | Number of tests: 6 08:42:59 INFO - PROCESS | 11360 | 08:42:59 INFO - PROCESS | 11360 | [#0] dojo.html Cycles:165 Average:5593.37 Median:5779.60 stddev:633.92 (11.0%) stddev-sans-first:607.84 08:42:59 INFO - PROCESS | 11360 | Values: 3217.3 3260.5 3266.0 3284.3 3304.3 5495.9 5588.4 5609.3 5618.4 5628.2 5570.3 5629.0 5637.2 5655.1 5667.3 5079.6 5102.6 5123.6 5123.6 5173.7 5011.3 5178.8 5184.6 5205.4 5208.3 5011.8 5063.8 5117.6 5119.7 5123.8 5178.5 5193.1 5255.6 5263.7 5279.5 4928.4 4932.6 5148.4 5167.4 5228.9 5475.0 5480.8 5496.3 5554.7 5592.0 5921.0 6008.0 6042.5 6050.6 6054.2 5891.6 5959.2 6067.2 6092.3 6112.5 5538.0 5569.7 5578.0 5618.9 5626.6 6125.7 6135.8 6142.0 6150.4 6156.0 5725.1 5774.8 5889.8 5896.6 5897.6 5936.9 5986.4 6017.8 6078.2 6109.5 6031.3 6048.1 6049.4 6061.6 6086.6 5808.6 5992.6 6042.0 6057.6 6068.6 4583.8 4618.8 4619.4 4642.5 4651.0 4133.8 4140.4 4142.9 4161.4 4167.2 5796.4 5802.0 5802.2 5813.4 5821.9 5664.3 5697.5 5739.3 5956.9 6053.3 5698.9 5768.9 5779.6 5786.9 5802.8 5191.4 5230.5 5247.4 5249.7 5253.8 6054.7 6313.9 6333.5 6333.7 6341.0 5843.8 6010.5 6025.2 6030.0 6124.3 6322.9 6332.7 6354.2 6364.8 6365.3 5891.0 5943.0 5949.9 5960.5 5964.1 5752.5 5810.7 6060.3 6079.1 6106.1 6049.9 6052.5 6065.8 6068.8 6077.8 6000.9 6013.9 6025.4 6025.6 6035.1 5590.1 5677.8 5716.4 5721.4 5987.9 5870.1 5879.9 5879.9 5881.4 5914.7 5407.4 5571.5 5618.9 5623.6 5629.7 08:42:59 INFO - PROCESS | 11360 | 08:42:59 INFO - PROCESS | 11360 | [#1] ext.html Cycles:180 Average:58379.75 Median:3601.37 stddev:111074.74 (3084.2%) stddev-sans-first:111301.53 08:42:59 INFO - PROCESS | 11360 | Values: 571.7 599.6 618.1 627.3 647.9 35578.8 45070.5 45811.3 45897.8 45965.8 47471.5 47874.8 47927.8 47964.5 47994.0 8456.3 8790.9 8908.1 8915.1 8946.2 8370.5 8564.2 8568.6 10487.8 10771.7 10936.1 10991.5 10996.7 11008.7 11014.8 10800.6 10847.4 10873.9 10875.2 10876.8 10535.5 10590.5 10602.7 10606.8 10608.4 44102.0 44267.3 44425.6 44430.3 44462.8 3475.4 3492.8 3596.9 3605.9 3618.9 30985.1 31059.0 31069.0 31219.8 31807.4 4010.9 4144.6 4191.4 4192.2 4269.0 339111.0 340190.0 340858.0 340879.3 342221.0 60438.4 60685.0 60731.7 60809.7 60937.1 38969.4 39726.8 39905.0 41397.4 41429.6 18676.2 18872.0 18887.6 18893.5 18900.0 12665.2 14525.5 14550.0 14684.6 14691.0 17848.4 19456.1 20802.4 20948.8 20973.9 7503.6 7669.8 7675.4 7698.7 7712.5 1011.3 1011.9 1051.5 1056.7 1139.1 32751.8 32757.2 32962.5 33584.8 34005.3 1077.0 1191.6 1268.2 1286.1 1298.7 16853.2 17551.9 17725.3 17792.3 17863.3 511753.0 514717.0 515549.0 515640.0 516493.0 62125.4 62676.4 62844.1 62878.4 62924.7 1345.2 1389.6 1401.7 1452.9 1464.0 32845.3 34729.5 34870.3 35114.6 35236.0 52289.5 52988.7 53036.7 53101.0 53113.5 384371.0 385526.0 386253.0 386937.0 388462.0 29925.3 31603.4 31652.7 31974.2 32587.8 47843.8 49625.5 49712.0 50400.5 50898.7 41857.2 42279.6 42926.4 43027.4 43034.4 41365.8 41719.0 41910.6 42725.1 43733.6 42022.8 43497.0 43525.9 44169.8 44255.6 31228.9 33416.8 33515.8 33583.0 33591.5 24590.8 24606.9 24719.4 25067.0 25076.4 08:42:59 INFO - PROCESS | 11360 | 08:42:59 INFO - PROCESS | 11360 | [#2] jquery.html Cycles:180 Average:23248.63 Median:11526.26 stddev:44073.41 (382.4%) stddev-sans-first:44163.63 08:42:59 INFO - PROCESS | 11360 | Values: 389.9 424.1 426.8 440.4 440.6 16135.0 19029.1 20305.1 20534.4 20547.3 19944.7 20149.2 20273.7 20349.8 20509.9 5625.2 5857.7 5858.1 5867.4 5867.7 5533.9 5773.8 5797.0 5800.9 5804.3 5679.1 5761.9 5763.6 5764.4 5766.0 5661.2 5668.4 5724.3 5754.3 5785.6 5146.5 5148.9 5185.2 5194.6 5204.6 23787.6 23896.5 23970.2 24011.5 24133.0 2258.9 2350.4 2418.7 2730.3 2795.5 14132.4 14312.6 14397.1 14654.6 15278.9 1788.1 1871.2 1880.7 1894.0 1908.9 84838.0 88806.6 93644.0 105492.0 106450.5 14768.6 17399.9 18017.3 18059.7 18998.4 30850.0 33819.7 33882.0 34019.7 34050.5 10656.7 10851.7 10916.6 10990.2 11147.5 8674.6 8757.4 8799.0 8870.8 9031.7 9130.2 9306.2 9321.4 9490.0 9583.2 3422.7 3441.0 3708.0 3780.6 3781.4 1046.5 1057.8 1071.3 1079.0 1079.8 18518.0 19168.0 20363.2 20452.2 20793.6 1034.2 1045.8 1080.8 1106.7 1110.2 10809.5 11233.7 11283.9 11364.7 11421.3 173246.0 173293.0 173432.0 174062.0 427864.0 93572.5 93622.1 95645.5 96381.0 97641.0 1048.2 1069.9 1103.4 1107.6 1108.2 17817.7 17949.9 18379.2 18424.4 18491.7 31698.2 35218.6 39956.0 40015.8 42695.6 56106.4 56432.4 56993.4 57653.1 58070.4 8687.4 8944.9 8978.0 8979.7 9025.1 12060.3 13328.3 13385.2 13467.5 13525.7 11906.4 12015.0 12049.5 12302.1 12719.2 11409.1 11681.5 11740.6 11763.4 12051.6 12101.9 12170.0 12338.6 12465.8 12480.6 8175.7 8789.6 8799.6 8993.9 9072.9 11917.8 12098.2 12240.3 12296.7 12447.3 08:42:59 INFO - PROCESS | 11360 | 08:42:59 INFO - PROCESS | 11360 | [#3] mootools.html Cycles:180 Average:5919.92 Median:4969.90 stddev:3272.92 (65.9%) stddev-sans-first:3265.57 08:42:59 INFO - PROCESS | 11360 | Values: 1542.6 1554.5 1747.7 1825.2 1859.2 8296.9 8831.9 8850.0 8852.8 8853.9 7853.3 8114.6 8369.4 8463.8 8729.7 2420.5 2477.9 2486.6 2488.3 2490.8 2409.5 2536.9 2555.7 2557.9 2559.4 2368.7 2391.2 2409.9 2454.6 2481.1 2408.7 2409.0 2427.2 2430.8 2435.6 2431.7 2433.2 2458.3 2460.7 2467.4 8878.6 8931.0 8992.6 9003.2 9023.2 5477.3 5616.7 5618.3 5621.4 5625.7 3420.7 3433.5 3504.3 3580.9 3586.1 1125.9 1145.8 1168.5 1178.3 1187.8 12287.8 12486.8 12544.6 12628.7 12636.9 4768.5 4946.9 5018.8 5038.1 5094.4 10669.9 10679.6 10679.8 10693.9 10711.9 5755.4 5768.3 5770.8 5781.7 5782.9 4519.2 4800.2 4992.9 5030.9 5196.3 4211.7 4264.8 4322.2 4346.2 4366.1 1361.4 1410.9 1414.7 1416.8 1432.3 807.1 928.8 945.7 966.6 1000.4 5904.0 5946.3 6124.2 6255.0 6303.1 969.2 978.5 987.9 1005.2 1025.5 4059.2 4271.9 4317.4 4322.3 4438.3 10423.0 10980.4 10984.6 10995.8 11054.6 10900.3 10905.8 10913.0 10914.7 10924.5 7959.4 8298.4 8307.3 8341.6 8473.2 5823.4 6040.3 6045.5 6218.5 6265.9 10277.5 10285.7 10286.8 10292.9 10335.8 9711.9 10105.5 10120.7 10232.5 10321.5 7934.6 8079.4 8093.2 8100.6 8109.3 8267.7 8459.2 8500.4 8544.1 8552.4 7368.7 7524.9 7535.8 7718.9 7722.7 7048.2 7103.4 7600.0 7741.0 7813.5 7263.5 7278.1 7281.4 7293.0 7333.3 5150.3 5246.4 5252.8 5361.0 5443.5 5223.6 5248.6 5260.0 5333.5 5350.6 08:42:59 INFO - PROCESS | 11360 | 08:42:59 INFO - PROCESS | 11360 | [#4] prototype.html Cycles:180 Average:4747.96 Median:5377.42 stddev:1382.46 (25.7%) stddev-sans-first:1346.32 08:42:59 INFO - PROCESS | 11360 | Values: 348.0 352.0 353.3 355.8 357.8 5347.2 5372.4 5372.6 5401.3 5450.5 5344.7 5346.7 5372.6 5402.8 5418.3 3753.0 4037.5 4106.0 4137.4 4240.0 4227.5 4232.6 4242.8 4250.5 4254.5 4225.4 4225.6 4244.2 4252.2 4255.4 4054.9 4063.6 4082.9 4250.9 4271.6 3730.6 3730.9 3732.9 3754.5 3769.6 5205.8 5216.1 5227.8 5240.3 5263.9 4726.6 4738.2 4811.1 4832.5 4840.4 5551.3 5552.9 5560.2 5566.9 5579.3 4113.7 4122.5 4127.5 4144.1 4156.6 5662.9 5777.9 5850.9 5876.2 5938.7 4191.4 4208.9 4219.5 4223.0 4237.9 4248.3 4251.2 4256.8 4262.6 4296.2 4703.9 4826.8 4837.6 4846.4 4851.4 5577.0 5579.9 5614.7 5616.6 5641.5 1422.4 1422.8 1426.0 1431.6 1441.5 972.5 1007.2 1014.6 1017.4 1038.0 5336.7 5354.8 5365.6 5390.2 5403.5 5577.4 5592.8 5594.6 5597.6 5614.4 5269.8 5329.4 5382.2 5540.6 5546.3 2960.3 2963.7 2975.6 2980.4 2984.6 5602.9 5848.3 5849.0 5861.6 5886.7 5619.4 5756.5 5761.4 5763.8 5774.8 5840.4 5853.0 6012.4 6041.8 6081.4 5843.0 5845.3 5845.4 5852.2 5860.0 5600.5 5724.7 5729.8 5778.6 5796.5 5983.5 6020.0 6037.6 6054.9 6064.3 4206.5 4221.7 4240.4 4263.7 4278.7 5631.8 5804.2 5807.7 5808.6 5832.9 5680.6 5688.9 5691.7 5693.5 5701.4 5535.4 5619.7 5654.9 5706.6 5717.6 5588.9 5606.7 5616.6 5636.7 5652.5 5649.8 5677.5 5693.3 5700.3 5700.5 5266.6 5383.8 5401.6 5409.8 5417.6 08:42:59 INFO - PROCESS | 11360 | 08:42:59 INFO - PROCESS | 11360 | [#5] yui.html Cycles:180 Average:17781.12 Median:4700.17 stddev:23694.59 (504.1%) stddev-sans-first:23726.36 08:42:59 INFO - PROCESS | 11360 | Values: 705.3 715.5 720.5 734.3 756.1 15170.8 15879.5 15889.6 15911.5 15978.6 13492.0 13506.0 13549.7 13553.7 13553.7 717.7 735.1 835.9 857.2 860.6 869.3 871.2 872.0 872.1 874.6 915.8 916.8 917.3 918.7 919.3 748.1 765.6 876.7 897.3 910.7 669.0 670.3 672.5 672.6 673.0 14458.5 14911.1 14947.6 14959.3 14963.6 12676.0 12984.7 13075.9 13156.3 13188.0 11204.3 11367.9 11530.4 11568.4 11790.9 3501.8 3615.5 3984.1 4037.3 4149.5 63591.7 64142.4 64829.7 65017.7 66601.0 10221.8 10223.0 10231.6 10404.1 10421.1 19750.2 19811.5 19824.1 19842.0 20084.0 7765.0 7968.3 8013.7 8038.8 8110.5 4407.1 4420.7 4486.0 4666.3 4743.4 3592.1 3657.9 3688.8 3731.3 3737.9 618.4 631.5 645.5 659.9 662.6 623.5 714.2 720.6 745.9 752.5 8918.8 9057.6 9118.7 9775.5 10057.6 691.4 706.6 756.5 768.2 818.7 4182.4 4673.7 4726.6 4824.6 4858.6 84941.6 85760.0 88031.6 89377.0 90458.5 70536.6 76147.6 76406.2 76569.0 78067.6 70570.0 71572.0 72623.9 72652.5 73875.6 8522.0 8704.9 8706.3 8783.3 8803.5 45052.8 45176.1 45990.3 46145.8 46559.0 56660.4 58531.0 61454.4 64410.4 65429.7 11525.8 11673.2 11788.5 11908.8 11945.4 12913.1 13026.5 13209.5 13226.2 13274.1 11540.7 12113.8 12186.3 12286.7 12409.3 12860.3 12881.5 13107.2 13181.9 13226.2 12391.4 12505.2 12730.0 13035.9 13182.6 9826.2 10240.5 10243.9 10370.4 10503.0 10897.3 10946.3 11009.2 11186.2 11297.9 08:42:59 INFO - PROCESS | 11360 | -------- Summary: end -------- 08:42:59 INFO - PROCESS | 11360 | 08:43:00 INFO - TEST-INFO | 11360: exit 0 08:43:00 INFO - TEST-OK | dromaeo_css | took 1115189ms 08:43:00 INFO - TEST-START | kraken 08:43:00 INFO - operating with platform_type : linux_ 08:43:00 INFO - Initialising browser for kraken test... 08:43:00 INFO - TEST-INFO | started process 11682 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD3N4Y8/profile http://localhost:42167/getInfo.html) 08:43:04 INFO - PROCESS | 11682 | __metrics Screen width/height:1600/1200 08:43:04 INFO - PROCESS | 11682 | colorDepth:24 08:43:04 INFO - PROCESS | 11682 | Browser inner width/height: 1024/697 08:43:04 INFO - PROCESS | 11682 | __metrics 08:43:04 INFO - PROCESS | 11682 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:43:04 INFO - PROCESS | 11682 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:43:05 INFO - PROCESS | 11682 | console.error: PushService: 08:43:05 INFO - PROCESS | 11682 | stateChangeProcessEnqueue: Error transitioning state 08:43:05 INFO - PROCESS | 11682 | UnknownError 08:43:05 INFO - TEST-INFO | 11682: exit 0 08:43:05 INFO - Browser initialized. 08:43:05 INFO - Running cycle 1/1 for kraken test... 08:43:05 INFO - TEST-INFO | started process 11781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD3N4Y8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:17 INFO - PROCESS | 11781 | RSS: Main: 144543744 08:43:17 INFO - PROCESS | 11781 | 08:43:20 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42167/tests/kraken/driver.html?testName=audio-beat-detection) 08:43:21 INFO - PROCESS | 11781 | RSS: Main: 185864192 08:43:21 INFO - PROCESS | 11781 | 08:43:23 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42167/tests/kraken/driver.html?testName=audio-dft) 08:43:24 INFO - PROCESS | 11781 | RSS: Main: 175046656 08:43:24 INFO - PROCESS | 11781 | 08:43:27 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42167/tests/kraken/driver.html?testName=audio-fft) 08:43:27 INFO - PROCESS | 11781 | RSS: Main: 265814016 08:43:27 INFO - PROCESS | 11781 | 08:43:29 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42167/tests/kraken/driver.html?testName=audio-oscillator) 08:43:30 INFO - PROCESS | 11781 | RSS: Main: 172978176 08:43:30 INFO - PROCESS | 11781 | 08:43:32 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42167/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:43:32 INFO - PROCESS | 11781 | RSS: Main: 175165440 08:43:32 INFO - PROCESS | 11781 | 08:43:35 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42167/tests/kraken/driver.html?testName=imaging-darkroom) 08:43:36 INFO - PROCESS | 11781 | RSS: Main: 214016000 08:43:36 INFO - PROCESS | 11781 | 08:43:39 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42167/tests/kraken/driver.html?testName=imaging-desaturate) 08:43:40 INFO - PROCESS | 11781 | RSS: Main: 212635648 08:43:40 INFO - PROCESS | 11781 | 08:43:43 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42167/tests/kraken/driver.html?testName=json-parse-financial) 08:43:43 INFO - PROCESS | 11781 | RSS: Main: 211406848 08:43:43 INFO - PROCESS | 11781 | 08:43:45 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42167/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:43:45 INFO - PROCESS | 11781 | RSS: Main: 173973504 08:43:45 INFO - PROCESS | 11781 | 08:43:47 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42167/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:43:48 INFO - PROCESS | 11781 | RSS: Main: 181108736 08:43:48 INFO - PROCESS | 11781 | 08:43:49 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42167/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:43:50 INFO - PROCESS | 11781 | RSS: Main: 189501440 08:43:50 INFO - PROCESS | 11781 | 08:43:53 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42167/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:43:53 INFO - PROCESS | 11781 | RSS: Main: 198598656 08:43:53 INFO - PROCESS | 11781 | 08:43:56 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42167/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:43:57 INFO - PROCESS | 11781 | RSS: Main: 194842624 08:43:57 INFO - PROCESS | 11781 | 08:43:58 INFO - PROCESS | 11781 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42167/tests/kraken/driver.html?testName=ai-astar) 08:43:58 INFO - PROCESS | 11781 | RSS: Main: 245354496 08:43:58 INFO - PROCESS | 11781 | 08:43:58 INFO - PROCESS | 11781 | __start_tp_report 08:43:58 INFO - PROCESS | 11781 | _x_x_mozilla_page_load 08:43:58 INFO - PROCESS | 11781 | _x_x_mozilla_page_load_details 08:43:58 INFO - PROCESS | 11781 | |i|pagename|runs| 08:43:58 INFO - PROCESS | 11781 | |0;ai-astar;103;109;108;110;109;111;110;108;111;110 08:43:58 INFO - PROCESS | 11781 | |1;audio-beat-detection;146;117;119;162;117;122;122;122;157;118 08:43:58 INFO - PROCESS | 11781 | |2;audio-dft;159;161;159;161;162;161;160;160;161;159 08:43:58 INFO - PROCESS | 11781 | |3;audio-fft;77;76;75;110;75;75;76;76;102;75 08:43:58 INFO - PROCESS | 11781 | |4;audio-oscillator;81;81;109;82;82;81;97;81;81;117 08:43:58 INFO - PROCESS | 11781 | |5;imaging-gaussian-blur;117;117;117;118;116;116;117;117;117;117 08:43:58 INFO - PROCESS | 11781 | |6;imaging-darkroom;146;146;146;146;146;166;146;146;146;146 08:43:58 INFO - PROCESS | 11781 | |7;imaging-desaturate;85;85;85;85;84;84;85;85;85;84 08:43:58 INFO - PROCESS | 11781 | |8;json-parse-financial;50;51;50;51;51;56;51;54;51;51 08:43:58 INFO - PROCESS | 11781 | |9;json-stringify-tinderbox;59;58;58;60;59;59;58;59;58;58 08:43:58 INFO - PROCESS | 11781 | |10;stanford-crypto-aes;75;74;80;74;76;83;78;74;74;74 08:43:58 INFO - PROCESS | 11781 | |11;stanford-crypto-ccm;123;122;136;137;122;130;119;117;159;122 08:43:58 INFO - PROCESS | 11781 | |12;stanford-crypto-pbkdf2;156;151;152;150;153;155;153;153;150;151 08:43:58 INFO - PROCESS | 11781 | |13;stanford-crypto-sha256-iterative;69;63;63;71;62;62;62;62;61;61 08:43:58 INFO - PROCESS | 11781 | __end_tp_report 08:43:58 INFO - PROCESS | 11781 | __start_cc_report 08:43:58 INFO - PROCESS | 11781 | _x_x_mozilla_cycle_collect,1594 08:43:58 INFO - PROCESS | 11781 | __end_cc_report 08:43:58 INFO - PROCESS | 11781 | __startTimestamp1483721038970__endTimestamp 08:43:58 INFO - PROCESS | 11781 | 08:43:58 INFO - PROCESS | 11781 | ------- Summary: start ------- 08:43:58 INFO - PROCESS | 11781 | Number of tests: 14 08:43:58 INFO - PROCESS | 11781 | 08:43:58 INFO - PROCESS | 11781 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:2.33 (2.1%) stddev-sans-first:1.13 08:43:58 INFO - PROCESS | 11781 | Values: 103.0 109.0 108.0 110.0 109.0 111.0 110.0 108.0 111.0 110.0 08:43:58 INFO - PROCESS | 11781 | 08:43:58 INFO - PROCESS | 11781 | [#1] audio-beat-detection Cycles:10 Average:130.20 Median:122.00 stddev:17.65 (14.5%) stddev-sans-first:17.77 08:43:58 INFO - PROCESS | 11781 | Values: 146.0 117.0 119.0 162.0 117.0 122.0 122.0 122.0 157.0 118.0 08:43:58 INFO - PROCESS | 11781 | 08:43:58 INFO - PROCESS | 11781 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.01 08:43:58 INFO - PROCESS | 11781 | Values: 159.0 161.0 159.0 161.0 162.0 161.0 160.0 160.0 161.0 159.0 08:43:58 INFO - PROCESS | 11781 | 08:43:58 INFO - PROCESS | 11781 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.50 stddev:12.96 (17.2%) stddev-sans-first:13.64 08:43:58 INFO - PROCESS | 11781 | Values: 77.0 76.0 75.0 110.0 75.0 75.0 76.0 76.0 102.0 75.0 08:43:58 INFO - PROCESS | 11781 | 08:43:58 INFO - PROCESS | 11781 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:81.00 stddev:13.60 (16.8%) stddev-sans-first:14.10 08:43:58 INFO - PROCESS | 11781 | Values: 81.0 81.0 109.0 82.0 82.0 81.0 97.0 81.0 81.0 117.0 08:43:58 INFO - PROCESS | 11781 | 08:43:58 INFO - PROCESS | 11781 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:43:58 INFO - PROCESS | 11781 | Values: 117.0 117.0 117.0 118.0 116.0 116.0 117.0 117.0 117.0 117.0 08:43:58 INFO - PROCESS | 11781 | 08:43:58 INFO - PROCESS | 11781 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:146.00 stddev:6.32 (4.3%) stddev-sans-first:6.67 08:43:58 INFO - PROCESS | 11781 | Values: 146.0 146.0 146.0 146.0 146.0 166.0 146.0 146.0 146.0 146.0 08:43:58 INFO - PROCESS | 11781 | 08:43:58 INFO - PROCESS | 11781 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 08:43:58 INFO - PROCESS | 11781 | Values: 85.0 85.0 85.0 85.0 84.0 84.0 85.0 85.0 85.0 84.0 08:43:58 INFO - PROCESS | 11781 | 08:43:58 INFO - PROCESS | 11781 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:51.00 stddev:1.90 (3.7%) stddev-sans-first:1.92 08:43:58 INFO - PROCESS | 11781 | Values: 50.0 51.0 50.0 51.0 51.0 56.0 51.0 54.0 51.0 51.0 08:43:58 INFO - PROCESS | 11781 | 08:43:58 INFO - PROCESS | 11781 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 08:43:58 INFO - PROCESS | 11781 | Values: 59.0 58.0 58.0 60.0 59.0 59.0 58.0 59.0 58.0 58.0 08:43:58 INFO - PROCESS | 11781 | 08:43:58 INFO - PROCESS | 11781 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:75.50 stddev:3.16 (4.2%) stddev-sans-first:3.32 08:43:58 INFO - PROCESS | 11781 | Values: 75.0 74.0 80.0 74.0 76.0 83.0 78.0 74.0 74.0 74.0 08:43:58 INFO - PROCESS | 11781 | 08:43:58 INFO - PROCESS | 11781 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:126.50 stddev:12.65 (10.0%) stddev-sans-first:13.25 08:43:58 INFO - PROCESS | 11781 | Values: 123.0 122.0 136.0 137.0 122.0 130.0 119.0 117.0 159.0 122.0 08:43:58 INFO - PROCESS | 11781 | 08:43:58 INFO - PROCESS | 11781 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.40 Median:153.00 stddev:2.01 (1.3%) stddev-sans-first:1.66 08:43:58 INFO - PROCESS | 11781 | Values: 156.0 151.0 152.0 150.0 153.0 155.0 153.0 153.0 150.0 151.0 08:43:58 INFO - PROCESS | 11781 | 08:43:58 INFO - PROCESS | 11781 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:62.50 stddev:3.47 (5.6%) stddev-sans-first:3.08 08:43:58 INFO - PROCESS | 11781 | Values: 69.0 63.0 63.0 71.0 62.0 62.0 62.0 62.0 61.0 61.0 08:43:58 INFO - PROCESS | 11781 | -------- Summary: end -------- 08:43:58 INFO - PROCESS | 11781 | 08:44:00 INFO - TEST-INFO | 11781: exit 0 08:44:00 INFO - TEST-OK | kraken | took 59933ms 08:44:00 INFO - SUITE-END | took 1175s 08:44:00 INFO - Completed test suite (00:19:35) 08:44:00 INFO - javascript benchmark 08:44:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3217.260030193055, 3260.527223552584, 3265.983670081649, 3284.261041265717, 3304.322613864158, 5495.862603434911, 5588.441155884409, 5609.3268807743125, 5618.381977982423, 5628.155776633507, 5570.275864137657, 5629.0, 5637.210790489325, 5655.123455864337, 5667.263255776754, 5079.64442489025, 5102.566281866046, 5123.5901127909865, 5123.615728820335, 5173.689578625275, 5011.298418221452, 5178.818741344054, 5184.611154163453, 5205.427402985688, 5208.348956380452, 5011.849644510652, 5063.84808455745, 5117.641765076446, 5119.718415487147, 5123.846284611449, 5178.5339319461245, 5193.091209038422, 5255.632105752599, 5263.736813159365, 5279.524842764131, 4928.383952005999, 4932.605391568666, 5148.382194136728, 5167.379914410295, 5228.895422091537, 5475.0418676731815, 5480.80817171401, 5496.31296087989, 5554.694491802949, 5592.0, 5921.0, 6008.0, 6042.456178943916, 6050.606710563799, 6054.152418661391, 5891.617044892068, 5959.195508606326, 6067.211262535842, 6092.299385570627, 6112.510999120104, 5538.030844602178, 5569.721513924287, 5578.023845826964, 5618.85952851182, 5626.578006649435, 6125.724342404603, 6135.785247516315, 6142.0, 6150.354212807681, 6156.045812899008, 5725.141228815628, 5774.769009239667, 5889.764409423661, 5896.587238893237, 5897.557683173779, 5936.851578710567, 5986.431289027535, 6017.789377371771, 6078.240219972504, 6109.450149486479, 6031.306399764083, 6048.0625503047095, 6049.425304596057, 6061.636301821904, 6086.573939824259, 5808.564357673192, 5992.610480318765, 6042.003069493572, 6057.575969682168, 6068.635881847015, 4583.770811459413, 4618.838340658128, 4619.353290539327, 4642.46611639659, 4650.976745116321, 4133.751974881517, 4140.420341152241, 4142.855000074983, 4161.396597493346, 4167.2082304362075, 5796.449337312949, 5802.0, 5802.245708057925, 5813.389594092644, 5821.941780582225, 5664.291963504562, 5697.515711164515, 5739.282589676291, 5956.85107872298, 6053.303870055, 5698.886022279531, 5768.913466298009, 5779.595428319977, 5786.913196302059, 5802.796902108406, 5191.351081114861, 5230.529252367305, 5247.422783493813, 5249.685018898878, 5253.816116435906, 6054.7275372607455, 6313.873722525524, 6333.524985626096, 6333.714982825692, 6341.048842673636, 5843.766249349978, 6010.489108425658, 6025.216721826135, 6030.03519436888, 6124.295705993868, 6322.873542529215, 6332.746690132343, 6354.23749150105, 6364.809055728336, 6365.3316401779, 5890.957579134906, 5943.0, 5949.881002380015, 5960.523158147251, 5964.075568286922, 5752.539796816328, 5810.738516766671, 6060.303065147565, 6079.05774604937, 6106.084087386927, 6049.939500604937, 6052.546059045501, 6065.757369705162, 6068.787592434243, 6077.817665470043, 6000.939990600213, 6013.939860601338, 6025.427584379477, 6025.638461692312, 6035.124906888389, 5590.077637189981, 5677.801276955452, 5716.371199168005, 5721.399253078367, 5987.940120598738, 5870.14882841994, 5879.882402351844, 5879.911801322898, 5881.353051164283, 5914.674692891932, 5407.432219616883, 5571.498565129158, 5618.85952851182, 5623.550115990793, 5629.690367029689], "value": 5551.057205203413, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.7370009795494, 599.5653151465189, 618.1130078337587, 627.2535682537776, 647.8963365861463, 35578.82210588946, 45070.549294507044, 45811.31283030749, 45897.7705111474, 45965.77017114918, 47471.52528474714, 47874.76062619682, 47927.760361198234, 47964.52035479644, 47994.0, 8456.281216096608, 8790.91209087909, 8908.064653211417, 8915.063918288584, 8946.194842464178, 8370.53962032088, 8564.229219370256, 8568.571571421404, 10487.842682359733, 10771.730706732316, 10936.070434013118, 10991.505382257777, 10996.725081872937, 11008.669739907775, 11014.834777478345, 10800.5679772809, 10847.403392813392, 10873.945630271837, 10875.238733288674, 10876.836847447215, 10535.525901334458, 10590.523426445829, 10602.681919542427, 10606.840897386546, 10608.416537090457, 44102.0, 44267.33598996018, 44425.55574444246, 44430.33354499653, 44462.77768611169, 3475.4439289713778, 3492.842822073013, 3596.856125754967, 3605.8918232452806, 3618.9095272618133, 30985.070447886374, 31059.0, 31069.0, 31219.84390078058, 31807.363852723047, 4010.859619913289, 4144.626983571463, 4191.392248124035, 4192.24539582875, 4268.9573104268875, 339111.0, 340190.0, 340858.0, 340879.29560352286, 342221.0, 60438.39561604416, 60685.0, 60731.69634151801, 60809.695951519956, 60937.08594371088, 38969.41545876814, 39726.801365992986, 39905.0, 41397.37903931444, 41429.58570414257, 18676.159572819255, 18872.0, 18887.622247554973, 18893.527661808566, 18900.0, 12665.176763510342, 14525.491607793676, 14550.0, 14684.559463216121, 14691.0, 17848.37530686446, 19456.07629833848, 20802.375928722162, 20948.790512094685, 20973.895130524554, 7503.585868429851, 7669.808254793563, 7675.424343174284, 7698.692052317844, 7712.534618422482, 1011.261778901406, 1011.9342242754344, 1051.4690081508788, 1056.7041228456044, 1139.0602752729033, 32751.836240818644, 32757.181070473427, 32962.50556241658, 33584.83207583995, 34005.31989360199, 1076.9730756731144, 1191.6186820217447, 1268.2390565660714, 1286.1382873474795, 1298.6558561981083, 16853.241604127845, 17551.912240438716, 17725.29098836032, 17792.288308467774, 17863.28546858111, 511753.0, 514717.0, 515549.0, 515640.0, 516493.0, 62125.37874621286, 62676.373236267056, 62844.05733913995, 62878.371216288164, 62924.68537657282, 1345.159275452842, 1389.5831250624772, 1401.663600735816, 1452.8765054970233, 1463.9853601464063, 32845.34309313848, 34729.47905781466, 34870.30259394849, 35114.64885351216, 35235.95999340806, 52289.477105229984, 52988.73505632447, 53036.73481632567, 53101.0, 53113.46886531085, 384371.0, 385526.0, 386253.0, 386937.0, 388462.0, 29925.251868703457, 31603.36793264168, 31652.683473164972, 31974.200644984063, 32587.837060814545, 47843.76078119587, 49625.503744963535, 49712.0, 50400.49599503958, 50898.74550627223, 41857.162856742085, 42279.577204227564, 42926.35610465908, 43027.35458968055, 43034.35448468213, 41365.793171033954, 41719.0, 41910.580894190665, 42725.1454970905, 43733.56266437295, 42022.78988605038, 43497.0, 43525.91185220395, 44169.77915110404, 44255.557444426435, 31228.947407818116, 33416.82540158681, 33515.83242083774, 33583.0, 33591.49612755762, 24590.754092459563, 24606.876965615058, 24719.38201544904, 25067.0, 25076.373090672878], "value": 20679.532147448946, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.9025243689078, 424.0703074030012, 426.7823410060869, 440.3504830375195, 440.57484527431023, 16135.0, 19029.143688534015, 20305.086271117798, 20534.38396848093, 20547.280845170404, 19944.700829487534, 20149.19403223873, 20273.69589456159, 20349.796502034977, 20509.897450512726, 5625.1843482695085, 5857.736401861926, 5858.091995740646, 5867.413258674141, 5867.735951882154, 5533.889322213553, 5773.826785196451, 5796.971015144918, 5800.9129863052085, 5804.303483581976, 5679.062954612484, 5761.9135712964335, 5763.596548241604, 5764.394738552454, 5766.0486019806685, 5661.207430959669, 5668.404817494165, 5724.341700704431, 5754.338251101114, 5785.566082543805, 5146.459621739701, 5148.897022059576, 5185.248139019821, 5194.6104042196985, 5204.609654275944, 23787.64318535206, 23896.522069558512, 23970.161044363365, 24011.51976960451, 24133.0, 2258.9322320330416, 2350.4476448034698, 2418.6734790803193, 2730.30377253799, 2795.5247607906704, 14132.36404361796, 14312.64218394538, 14397.13617182962, 14654.633634159125, 15278.923605381902, 1788.1416919878402, 1871.1579789094963, 1880.7366968624403, 1893.9715904261448, 1908.8568357373254, 84838.0, 88806.5559672204, 93644.0, 105492.0, 106450.46774766155, 14768.609457548133, 17399.91300043517, 18017.2793088275, 18059.729104063448, 18998.43004709861, 30850.0, 33819.66180338214, 33882.0, 34019.659803402144, 34050.48924266138, 10656.655535782116, 10851.67444976652, 10916.617918372818, 10990.230683852054, 11147.498362573542, 8674.56627168639, 8757.430767000253, 8798.956005220061, 8870.778230544289, 9031.729048128567, 9130.223930965942, 9306.162445379949, 9321.44071355721, 9490.0, 9583.233341332816, 3422.743294252941, 3440.9655903440644, 3707.981460092736, 3780.584135745121, 3781.357169281174, 1046.4819914142547, 1057.799018186542, 1071.3250652089134, 1078.983815242772, 1079.7624522605015, 18518.0, 19168.0, 20363.18547258093, 20452.181912723623, 20793.58412831735, 1034.1984961654778, 1045.8274384726435, 1080.8324709670014, 1106.7343837478948, 1110.2006555280186, 10809.459527023617, 11233.719157020976, 11283.887161128283, 11364.715882103013, 11421.314721116594, 173246.0, 173293.0, 173432.0, 174062.0, 427864.0, 93572.53213734024, 93622.06377936133, 95645.52177239208, 96381.0, 97641.0, 1048.1771809129796, 1069.8716154061563, 1103.382106020631, 1107.6044184327804, 1108.2187058124002, 17817.73273400926, 17949.910250449186, 18379.17293721759, 18424.35514756977, 18491.722624160917, 31698.207544811565, 35218.64781352154, 39956.0, 40015.79992100137, 42695.5730442704, 56106.43893561175, 56432.43567564436, 56993.43006569881, 57653.13520297115, 58070.4192958065, 8687.409113243059, 8944.910550894409, 8977.955110224408, 8979.730608081769, 9025.052369501107, 12060.336681482602, 13328.333583320602, 13385.19688818674, 13467.528636497676, 13525.729485410433, 11906.404679765803, 12015.0, 12049.457774400349, 12302.138850280395, 12719.173253738478, 11409.144314176305, 11681.532738690697, 11740.58907938218, 11763.353015583883, 12051.57819476314, 12101.939490302844, 12170.0, 12338.629841104781, 12465.813012804634, 12480.56318028901, 8175.67297308101, 8789.560521974003, 8799.648014079621, 8993.910060899569, 9072.863907041532, 11917.82123268169, 12098.213616114925, 12240.326782027074, 12296.692582685504, 12447.253164810141], "value": 10106.644794777276, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1542.6474626195052, 1554.471479696903, 1747.7291019891913, 1825.2425243523937, 1859.2191279662532, 8296.875546866795, 8831.91168088319, 8850.026497085315, 8852.822943541125, 8853.911460885389, 7853.332466740334, 8114.634841432135, 8369.372297077713, 8463.830723385528, 8729.694460693878, 2420.4553975355534, 2477.8513289202615, 2486.639437281593, 2488.340589743719, 2490.8007359411204, 2409.5421869844763, 2536.936576585582, 2555.706093799209, 2557.884895179712, 2559.398541342783, 2368.7039120109985, 2391.234804862445, 2409.8915548800346, 2454.5704501712216, 2481.0695989004125, 2408.722996855358, 2408.976185121325, 2427.1990243219693, 2430.805535557151, 2435.6346548017764, 2431.7203521595065, 2433.197044975154, 2458.2870967419426, 2460.7047154341412, 2467.383154211447, 8878.600462979117, 8931.0, 8992.595333210022, 9003.234725048378, 9023.233025192802, 5477.3427188737205, 5616.719164041822, 5618.297712785902, 5621.437856214346, 5625.6905870177125, 3420.675035871588, 3433.4506478963494, 3504.281622267429, 3580.9283814323826, 3586.103474131467, 1125.8536390269212, 1145.8223975283845, 1168.5442677355838, 1178.3401295274673, 1187.780260651782, 12287.754244915051, 12486.75026499474, 12544.560940367044, 12628.747425051448, 12636.936815315865, 4768.47546769855, 4946.9010619787405, 5018.799248030111, 5038.067957427887, 5094.439611642716, 10669.89330106689, 10679.57281708723, 10679.78640427187, 10693.893061069446, 10711.89288107109, 5755.424457554295, 5768.307803063659, 5770.826875193751, 5781.682007489629, 5782.942170578324, 4519.231730605805, 4800.183968725325, 4992.900141997213, 5030.899382012412, 5196.32447781786, 4211.7262377945335, 4264.829406823755, 4322.222000040023, 4346.195953748504, 4366.104948485553, 1361.4418088583832, 1410.9223992680295, 1414.6746248362933, 1416.7803990381508, 1432.298173894784, 807.0937207910678, 928.758522784081, 945.6879229854131, 966.6230170233614, 1000.4297550396204, 5903.970480147572, 5946.256717910262, 6124.173236613089, 6255.0, 6303.117563541108, 969.2149359019216, 978.5058545434653, 987.9259055570861, 1005.1757558801859, 1025.5231317437429, 4059.2084543513733, 4271.914561708811, 4317.41714868495, 4322.265214913409, 4438.267685831866, 10423.0, 10980.396078215615, 10984.615538456115, 10995.835062474069, 11054.557817687364, 10900.34597924127, 10905.781884362426, 10913.0, 10914.672559823219, 10924.508397122148, 7959.363250939911, 8298.419110662317, 8307.335413166933, 8341.582920853933, 8473.195046470699, 5823.417658234142, 6040.335563088145, 6045.486133678686, 6218.533609979179, 6265.906011409924, 10277.537510811882, 10285.691429257135, 10286.845697314397, 10292.948535257276, 10335.793284134124, 9711.9028809711, 10105.494725263854, 10120.696379108638, 10232.53953572106, 10321.48392580383, 7934.60326983637, 8079.434439589408, 8093.231143041402, 8100.594970251346, 8109.270165685117, 8267.710630127916, 8459.154084591491, 8500.362472814688, 8544.145585441405, 8552.401331906956, 7368.668409921459, 7524.887126692995, 7535.773926782205, 7718.884216736641, 7722.691092356243, 7048.154221493453, 7103.396211322096, 7600.0, 7741.0, 7813.492123011986, 7263.491555591269, 7278.09023872016, 7281.417486601165, 7293.0, 7333.303336183054, 5150.278960945546, 5246.3704355477585, 5252.789888404421, 5360.973195133999, 5443.455654434525, 5223.634345595772, 5248.606354523502, 5259.973700131475, 5333.5199832015305, 5350.6254562180275], "value": 4787.905490302106, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.9878204262851, 351.99648003519957, 353.27225914615894, 355.7598620930871, 357.8425492783175, 5347.224652425396, 5372.382176049756, 5372.615252390998, 5401.3248343957, 5450.482204190605, 5344.679319240849, 5346.743515273917, 5372.597055220865, 5402.756875940582, 5418.2685337479425, 3753.0, 4037.4953130858644, 4105.958940410587, 4137.379393091045, 4240.045989652334, 4227.450431443908, 4232.619064284214, 4242.80907359168, 4250.48994120706, 4254.468191476066, 4225.429567008446, 4225.556316586761, 4244.236037513247, 4252.19208350414, 4255.4467919170465, 4054.8574854487715, 4063.553009168989, 4082.8571000015154, 4250.893727656802, 4271.63691086258, 3730.645588669072, 3730.8880733578035, 3732.9361132077497, 3754.530683664542, 3769.6230376962358, 5205.817796377109, 5216.061109000379, 5227.785655795016, 5240.3187585614005, 5263.86840328991, 4726.558399688094, 4738.218193997986, 4811.13399588074, 4832.516748325174, 4840.443349014838, 5551.306086739158, 5552.944470555323, 5560.165145501975, 5566.916496252559, 5579.330480342344, 4113.650339721127, 4122.484689413824, 4127.545969943304, 4144.129732756125, 4156.646685031776, 5662.943370566283, 5777.913331299992, 5850.9414905851245, 5876.236089308405, 5938.703064846741, 4191.371294305817, 4208.85269015583, 4219.451471308772, 4222.9577704223175, 4237.915241695149, 4248.277792775236, 4251.192273468031, 4256.765877876746, 4262.552431994658, 4296.183725092223, 4703.882402939954, 4826.831060912851, 4837.612990960714, 4846.36997190363, 4851.442084160296, 5577.0, 5579.944200558024, 5614.719264036864, 5616.634918730269, 5641.464060914206, 1422.4381369359046, 1422.8292604887272, 1425.978610320846, 1431.5848403962943, 1441.466657336771, 972.4602845420859, 1007.1791489935679, 1014.5637375928274, 1017.4454922067491, 1038.0346277961416, 5336.706481143575, 5354.7951710864745, 5365.570754339644, 5390.21841832932, 5403.486668766461, 5577.358603760619, 5592.8042518512475, 5594.608377413542, 5597.636153650081, 5614.410486898899, 5269.762860671279, 5329.360476742738, 5382.219578161144, 5540.612157148961, 5546.27898373217, 2960.3487232808748, 2963.748081413104, 2975.642922849229, 2980.4203772000874, 2984.552317152401, 5602.851415459821, 5848.3274423441, 5848.970755146197, 5861.596745334393, 5886.676232807236, 5619.381867994517, 5756.481916627524, 5761.39505351932, 5763.827085187451, 5774.82675519735, 5840.445157710011, 5852.970735146297, 6012.368701286302, 6041.758329666764, 6081.39186081406, 5843.0, 5845.311156867719, 5845.41545845412, 5852.18069470266, 5860.0, 5600.4959553640365, 5724.656520608777, 5729.799457018984, 5778.624389414675, 5796.478316951495, 5983.521318294439, 6020.0, 6037.63774173551, 6054.90917636227, 6064.332923378337, 4206.537280899038, 4221.662267018693, 4240.4487416636875, 4263.701540892108, 4278.67909906752, 5631.802886898939, 5804.216430781959, 5807.651540907559, 5808.601967848686, 5832.912506312324, 5680.573956953328, 5688.943110568841, 5691.686957217393, 5693.4875861172695, 5701.40135285789, 5535.418781027934, 5619.747111379916, 5654.943450565442, 5706.629069110494, 5717.628354156966, 5588.86027849307, 5606.6636001840025, 5616.634918730269, 5636.661800291996, 5652.463016013472, 5649.830505084854, 5677.545796336366, 5693.259876216065, 5700.287464066992, 5700.543956483554, 5266.578673706018, 5383.7846486140115, 5401.621886468067, 5409.78360865561, 5417.620766546462], "value": 4313.832445305234, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.2841366013497, 715.5384776818951, 720.5208536323345, 734.2767374136474, 756.1077928044912, 15170.84829151708, 15879.52361429156, 15889.602759931007, 15911.522654320375, 15978.600534986632, 13491.988100892424, 13506.0, 13549.729005419911, 13553.661158471019, 13553.661158471043, 717.6842189436632, 735.1435577552145, 835.853725598018, 857.2113655436997, 860.6127242740761, 869.3393021303823, 871.1897934920521, 872.0233338660709, 872.0538216035609, 874.6064271078009, 915.771057235691, 916.7983043730369, 917.3028498341242, 918.7335672654956, 919.3059240273584, 748.1022772672815, 765.6248438265238, 876.7457437343163, 897.2821742605889, 910.717677519971, 669.009865399207, 670.3464122480591, 672.5225090185974, 672.6065251827687, 673.0241150332038, 14458.493952711604, 14911.105333680014, 14947.551573452814, 14959.326830292553, 14963.551093467104, 12676.0, 12984.740305193938, 13075.86924130756, 13156.342182890912, 13188.0, 11204.271722338022, 11367.886321136766, 11530.42347882611, 11568.363739994296, 11790.88209117915, 3501.842417091237, 3615.511905892697, 3984.1035766952496, 4037.3338399164104, 4149.481314835645, 63591.68204158996, 64142.3585764141, 64829.67585162091, 65017.67491162514, 66601.0, 10221.824490183724, 10223.0, 10231.56758053873, 10404.063634272952, 10421.114205292484, 19750.209991600175, 19811.504712382306, 19824.107915143853, 19842.007899604963, 20084.0, 7764.961175194087, 7968.282854543003, 8013.719519816778, 8038.839223215503, 8110.472819266847, 4407.118576284756, 4420.689827418241, 4486.013077123028, 4666.300054991711, 4743.359646447685, 3592.0660628236847, 3657.8902632921054, 3688.7786732796117, 3731.2910546995986, 3737.9252414951548, 618.4032408725601, 631.5389765471232, 645.493287769099, 659.8518577674907, 662.6189940783972, 623.4513628007415, 714.1786945013276, 720.5964659790534, 745.9142198647116, 752.5183882315323, 8918.777030574158, 9057.637694492278, 9118.726438206864, 9775.51122443875, 10057.647982320585, 691.4295706042535, 706.5584009993754, 756.5196100476127, 768.1511929318135, 818.7257268815014, 4182.435371224907, 4673.742944138037, 4726.598239149642, 4824.565789079, 4858.562729354305, 84941.57529212315, 85760.0, 88031.55984220038, 89377.0, 90458.54770726104, 70536.64731676309, 76147.61926190334, 76406.23593764102, 76569.0, 78067.60966195133, 70569.99999999897, 71572.0, 72623.91064134042, 72652.54694906178, 73875.63062184762, 8521.957390213009, 8704.91295087041, 8706.3034957202, 8783.341249406192, 8803.471791692518, 45052.774736126106, 45176.09647807091, 45990.310145348514, 46145.76927115343, 46559.0, 56660.43339566716, 58531.0, 61454.38545614666, 64410.355896442314, 65429.672851635434, 11525.769484610428, 11673.241239319417, 11788.528458861892, 11908.821367679318, 11945.4027298633, 12913.09608327408, 13026.47894084226, 13209.471621135432, 13226.206427614374, 13274.137181083199, 11540.711482213012, 12113.75772484563, 12186.268823870241, 12286.692832679255, 12409.255444673348, 12860.2926839021, 12881.48474061027, 13107.213567186, 13181.934090329487, 13226.206427614374, 12391.380430978235, 12505.249685018563, 12730.0, 13035.934820325838, 13182.60452186436, 9826.213902887608, 10240.48797560134, 10243.94878025605, 10370.42962637032, 10503.002214789583, 10897.291676041032, 10946.288491248044, 11009.174311926477, 11186.161037922026, 11297.943510282395], "value": 7136.0195361347105, "unit": "score"}], "name": "dromaeo_css", "value": 7450.2725671320695, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 109.0, 108.0, 110.0, 109.0, 111.0, 110.0, 108.0, 111.0, 110.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 119.0, 162.0, 117.0, 122.0, 122.0, 122.0, 157.0, 118.0], "value": 130.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 159.0, 161.0, 162.0, 161.0, 160.0, 160.0, 161.0, 159.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 110.0, 75.0, 75.0, 76.0, 76.0, 102.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 109.0, 82.0, 82.0, 81.0, 97.0, 81.0, 81.0, 117.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 166.0, 146.0, 146.0, 146.0, 146.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 85.0, 85.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 51.0, 51.0, 56.0, 51.0, 54.0, 51.0, 51.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 60.0, 59.0, 59.0, 58.0, 59.0, 58.0, 58.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 80.0, 74.0, 76.0, 83.0, 78.0, 74.0, 74.0, 74.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 136.0, 137.0, 122.0, 130.0, 119.0, 117.0, 159.0, 122.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 151.0, 152.0, 150.0, 153.0, 155.0, 153.0, 153.0, 150.0, 151.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 63.0, 63.0, 71.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1451.0, "alertThreshold": 2.0}]} 08:44:00 INFO - Return code: 0 08:44:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:44:00 INFO - # TBPL SUCCESS # 08:44:00 INFO - Running post-action listener: _resource_record_post_action 08:44:00 INFO - [mozharness: 2017-01-06 16:44:00.310206Z] Finished run-tests step (success) 08:44:00 INFO - Running post-run listener: _resource_record_post_run 08:44:00 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 581632; Write bytes: 358301696; Read time: 64; Write time: 222660 08:44:00 INFO - TinderboxPrint: CPU usage
13.0% 08:44:00 INFO - TinderboxPrint: I/O read bytes / time
581,632 / 64 08:44:00 INFO - TinderboxPrint: I/O write bytes / time
358,301,696 / 222,660 08:44:00 INFO - TinderboxPrint: CPU idle
8,271.6 (87.0%) 08:44:00 INFO - TinderboxPrint: CPU user
1,190.2 (12.5%) 08:44:00 INFO - TinderboxPrint: Swap in / out
0 / 0 08:44:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108216320; Read time: 0; Write time: 75932 08:44:00 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 581632; Write bytes: 249577472; Read time: 64; Write time: 146700 08:44:00 INFO - Running post-run listener: _upload_blobber_files 08:44:00 INFO - Blob upload gear active. 08:44:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:44:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:44:00 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'] 08:44:00 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 08:44:01 INFO - (blobuploader) - INFO - Open directory for files ... 08:44:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:44:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:44:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:02 INFO - (blobuploader) - INFO - Done attempting. 08:44:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:44:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:44:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:02 INFO - (blobuploader) - INFO - Done attempting. 08:44:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:44:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:44:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:06 INFO - (blobuploader) - INFO - Done attempting. 08:44:06 INFO - (blobuploader) - INFO - Iteration through files over. 08:44:06 INFO - Return code: 0 08:44:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:44:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:44:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1658292ff836aa94cfe8b8ccc337676e5ea51567b94d3f2af5614e29be87b141da72e266a56ce1266a63992fc36b60f1f17e8a23d11549b28c0177310014cc7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69363e71b0aa2a3d7f7777f918e36b6a9ed5cb0e355a53dc9f575c6857a45f79092b9c4e2e000b425b9a8f762b45292a112b57fc94e6ce2728647bcb917a94f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99f3172d3da72542b6f69cf059576dbd1a102655f09c6e31fe5d7456fab57305e247a026ff3583e2423771bede50aadff7637af677327ac275df6602d87f9c8b"} 08:44:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:44:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:44:06 INFO - Contents: 08:44:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1658292ff836aa94cfe8b8ccc337676e5ea51567b94d3f2af5614e29be87b141da72e266a56ce1266a63992fc36b60f1f17e8a23d11549b28c0177310014cc7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69363e71b0aa2a3d7f7777f918e36b6a9ed5cb0e355a53dc9f575c6857a45f79092b9c4e2e000b425b9a8f762b45292a112b57fc94e6ce2728647bcb917a94f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99f3172d3da72542b6f69cf059576dbd1a102655f09c6e31fe5d7456fab57305e247a026ff3583e2423771bede50aadff7637af677327ac275df6602d87f9c8b"} 08:44:06 INFO - Running post-run listener: copy_logs_to_upload_dir 08:44:06 INFO - Copying logs to upload dir... 08:44:06 INFO - mkdir: /builds/slave/test/build/upload/logs 08:44:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.957344 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-01-06 08:44:06.507667) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 08:44:06.510957) ========= 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=c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1658292ff836aa94cfe8b8ccc337676e5ea51567b94d3f2af5614e29be87b141da72e266a56ce1266a63992fc36b60f1f17e8a23d11549b28c0177310014cc7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69363e71b0aa2a3d7f7777f918e36b6a9ed5cb0e355a53dc9f575c6857a45f79092b9c4e2e000b425b9a8f762b45292a112b57fc94e6ce2728647bcb917a94f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99f3172d3da72542b6f69cf059576dbd1a102655f09c6e31fe5d7456fab57305e247a026ff3583e2423771bede50aadff7637af677327ac275df6602d87f9c8b"} build_url:https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011741 build_url: 'https://queue.taskcluster.net/v1/task/S86aRLUkTMSKWK6DeRDWsA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1658292ff836aa94cfe8b8ccc337676e5ea51567b94d3f2af5614e29be87b141da72e266a56ce1266a63992fc36b60f1f17e8a23d11549b28c0177310014cc7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69363e71b0aa2a3d7f7777f918e36b6a9ed5cb0e355a53dc9f575c6857a45f79092b9c4e2e000b425b9a8f762b45292a112b57fc94e6ce2728647bcb917a94f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99f3172d3da72542b6f69cf059576dbd1a102655f09c6e31fe5d7456fab57305e247a026ff3583e2423771bede50aadff7637af677327ac275df6602d87f9c8b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 08:44:06.536682) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 08:44:06.537074) ========= 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=c6927cf182745ad25b1d38b9000001fe-1483719804.499486-312139413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 08:44:06.586780) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 08:44:06.587093) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 08:44:06.587394) ========= ========= Total master_lag: 0.23 =========