builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1483464584.05 results: success (0) buildid: 20170103074820 builduid: 21a0f0db02d84a778bd6b50546281e7f revision: 218db8b47b80de47bf6fe624aea9c545a3e01e4e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 09:29:44.054809) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 09:29:44.055285) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 09:29:44.055625) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 09:29:44.070274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 09:29:44.070597) ========= 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=0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-03 09:29:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.0M=0s 2017-01-03 09:29:44 (69.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.079623 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 09:29:44.164239) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 09:29:44.164557) ========= 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=0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013795 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 09:29:44.213862) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 09:29:44.214230) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 218db8b47b80de47bf6fe624aea9c545a3e01e4e --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 218db8b47b80de47bf6fe624aea9c545a3e01e4e --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=0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-03 09:29:44,317 truncating revision to first 12 chars 2017-01-03 09:29:44,317 Setting DEBUG logging. 2017-01-03 09:29:44,317 attempt 1/10 2017-01-03 09:29:44,317 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/218db8b47b80?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-03 09:29:44,617 unpacking tar archive at: mozilla-aurora-218db8b47b80/testing/mozharness/ program finished with exit code 0 elapsedTime=0.591157 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 09:29:44.819861) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 09:29:44.820191) ========= script_repo_revision: 218db8b47b80de47bf6fe624aea9c545a3e01e4e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 09:29:44.820601) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 09:29:44.820878) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 09:29:44.831443) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-03 09:29:44.831742) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:29:45 INFO - MultiFileLogger online at 20170103 09:29:45 in /builds/slave/test 09:29:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:29:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:29:45 INFO - {'append_to_log': False, 09:29:45 INFO - 'base_work_dir': '/builds/slave/test', 09:29:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:29:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:29:45 INFO - 'branch': 'Mozilla-Aurora', 09:29:45 INFO - 'buildbot_json_path': 'buildprops.json', 09:29:45 INFO - 'config_files': ('talos/linux_config.py',), 09:29:45 INFO - 'default_actions': ('clobber', 09:29:45 INFO - 'read-buildbot-config', 09:29:45 INFO - 'download-and-extract', 09:29:45 INFO - 'populate-webroot', 09:29:45 INFO - 'create-virtualenv', 09:29:45 INFO - 'install', 09:29:45 INFO - 'run-tests'), 09:29:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:29:45 INFO - 'download_minidump_stackwalk': True, 09:29:45 INFO - 'download_symbols': 'ondemand', 09:29:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:29:45 INFO - 'tooltool.py': '/tools/tooltool.py', 09:29:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:29:45 INFO - '/tools/misc-python/virtualenv.py')}, 09:29:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:29:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:29:45 INFO - 'installer_path': 'installer.exe', 09:29:45 INFO - 'log_level': 'info', 09:29:45 INFO - 'log_name': 'talos', 09:29:45 INFO - 'log_to_console': True, 09:29:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:29:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:29:45 INFO - 'opt_config_files': (), 09:29:45 INFO - 'pip_index': False, 09:29:45 INFO - 'sps_profile': False, 09:29:45 INFO - 'sps_profile_interval': 0, 09:29:45 INFO - 'suite': 'dromaeojs-e10s', 09:29:45 INFO - 'system_bits': '32', 09:29:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:29:45 INFO - 'title': 'talos-linux64-ix-058', 09:29:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:29:45 INFO - 'use_talos_json': True, 09:29:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:29:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:29:45 INFO - 'work_dir': 'build'} 09:29:45 INFO - [mozharness: 2017-01-03 17:29:45.030286Z] Running clobber step. 09:29:45 INFO - Running pre-action listener: _resource_record_pre_action 09:29:45 INFO - Running main action method: clobber 09:29:45 INFO - rmtree: /builds/slave/test/build 09:29:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:29:45 INFO - Running post-action listener: _resource_record_post_action 09:29:45 INFO - [mozharness: 2017-01-03 17:29:45.483791Z] Finished clobber step (success) 09:29:45 INFO - [mozharness: 2017-01-03 17:29:45.483890Z] Running read-buildbot-config step. 09:29:45 INFO - Running pre-action listener: _resource_record_pre_action 09:29:45 INFO - Running main action method: read_buildbot_config 09:29:45 INFO - Using buildbot properties: 09:29:45 INFO - { 09:29:45 INFO - "project": "", 09:29:45 INFO - "product": "firefox", 09:29:45 INFO - "script_repo_revision": "production", 09:29:45 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:29:45 INFO - "repository": "", 09:29:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:29:45 INFO - "buildid": "20170103074820", 09:29:45 INFO - "pgo_build": "True", 09:29:45 INFO - "basedir": "/builds/slave/test", 09:29:45 INFO - "buildnumber": 712, 09:29:45 INFO - "slavename": "talos-linux64-ix-058", 09:29:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:29:45 INFO - "platform": "ubuntu64_hw", 09:29:45 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:29:45 INFO - "branch": "mozilla-aurora", 09:29:45 INFO - "repo_path": "releases/mozilla-aurora", 09:29:45 INFO - "revision": "218db8b47b80de47bf6fe624aea9c545a3e01e4e", 09:29:45 INFO - "stage_platform": "linux64-pgo", 09:29:45 INFO - "builduid": "21a0f0db02d84a778bd6b50546281e7f", 09:29:45 INFO - "slavebuilddir": "test" 09:29:45 INFO - } 09:29:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 09:29:45 INFO - Running post-action listener: _resource_record_post_action 09:29:45 INFO - [mozharness: 2017-01-03 17:29:45.486542Z] Finished read-buildbot-config step (success) 09:29:45 INFO - [mozharness: 2017-01-03 17:29:45.486629Z] Running download-and-extract step. 09:29:45 INFO - Running pre-action listener: _resource_record_pre_action 09:29:45 INFO - Running main action method: download_and_extract 09:29:45 INFO - mkdir: /builds/slave/test/build/tests 09:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:45 INFO - trying https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:29:45 INFO - Downloading https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/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 09:29:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/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 09:29:46 INFO - Downloaded 1361 bytes. 09:29:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:29:46 INFO - Using the following test package requirements: 09:29:46 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:29:46 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:29:46 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:29:46 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:29:46 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:29:46 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:29:46 INFO - u'jsshell-linux-x86_64.zip'], 09:29:46 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:29:46 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:29:46 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:29:46 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:29:46 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:29:46 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:29:46 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:29:46 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:29:46 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:29:46 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:29:46 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:29:46 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:29:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:29:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:29:46 INFO - Fetch https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:29:46 INFO - Http code: 200 09:29:46 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 09:29:46 INFO - x-amz-cf-id: DAjm2mpPTTNc4BjCAkCURYFuGVLHkDxt2uDxMJ6f4OWrDTn0JCxyjQ== 09:29:46 INFO - x-amz-version-id: bSoipvmtmSrYoBm8pR279XDuxfftF_Wa 09:29:46 INFO - Expected file size: 21942557 09:29:46 INFO - Obtained file size: 21942557 09:29:50 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 09:29:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:29:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:29:50 INFO - Fetch https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:29:51 INFO - Http code: 200 09:29:51 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 09:29:51 INFO - x-amz-cf-id: QF9mRH-W3ZeTrxAZzwcCCq0T-eAse1HcYPhgHrHyfiwqyXWehBSIlA== 09:29:51 INFO - x-amz-version-id: bSoipvmtmSrYoBm8pR279XDuxfftF_Wa 09:29:51 INFO - Expected file size: 21942557 09:29:51 INFO - Obtained file size: 21942557 09:29:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 09:29:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:29:56 INFO - Fetch https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:29:56 INFO - Http code: 200 09:29:56 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 09:29:56 INFO - x-amz-cf-id: dqBiv-dJWs1cOmDakJmGL3212TfObpLHb4XiAp4PYRjvX1PjD_dzNQ== 09:29:56 INFO - x-amz-version-id: aFIoK4MKxCAgHlEX1eHiXsr7al7nD5iM 09:29:56 INFO - Expected file size: 14409038 09:29:56 INFO - Obtained file size: 14409038 09:29:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:57 INFO - trying https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:29:57 INFO - Downloading https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/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 09:29:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/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 09:29:58 INFO - Downloaded 64008469 bytes. 09:29:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:29:58 INFO - mkdir: /builds/slave/test/properties 09:29:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:29:58 INFO - Writing to file /builds/slave/test/properties/build_url 09:29:58 INFO - Contents: 09:29:58 INFO - build_url:https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:29:58 INFO - Running post-action listener: _resource_record_post_action 09:29:58 INFO - Running post-action listener: set_extra_try_arguments 09:29:58 INFO - [mozharness: 2017-01-03 17:29:58.826200Z] Finished download-and-extract step (success) 09:29:58 INFO - [mozharness: 2017-01-03 17:29:58.826426Z] Running populate-webroot step. 09:29:58 INFO - Running pre-action listener: _resource_record_pre_action 09:29:58 INFO - Running main action method: populate_webroot 09:29:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:29:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:29:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:29:58 INFO - '--tppagecycles', 09:29:58 INFO - '7'], 09:29:58 INFO - 'tests': ['tsvgm']}}, 09:29:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:29:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:29:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:29:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:29:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:29:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:29:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:58 INFO - 'talos_options': ['--disable-e10s'], 09:29:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:29:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:29:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:58 INFO - 'talos_options': ['--disable-e10s'], 09:29:58 INFO - 'tests': ['damp', 'tps']}, 09:29:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:58 INFO - 'tests': ['damp', 'tps']}, 09:29:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:29:58 INFO - 'tests': ['dromaeo_dom']}, 09:29:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:29:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:29:58 INFO - 'tests': ['basic_compositor_video']}, 09:29:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:29:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:29:58 INFO - 'tests': ['a11yr', 09:29:58 INFO - 'ts_paint', 09:29:58 INFO - 'tpaint', 09:29:58 INFO - 'sessionrestore', 09:29:58 INFO - 'sessionrestore_no_auto_restore', 09:29:58 INFO - 'tabpaint']}, 09:29:58 INFO - 'other-e10s': {'tests': ['a11yr', 09:29:58 INFO - 'ts_paint', 09:29:58 INFO - 'tpaint', 09:29:58 INFO - 'sessionrestore', 09:29:58 INFO - 'sessionrestore_no_auto_restore', 09:29:58 INFO - 'tabpaint']}, 09:29:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:29:58 INFO - 'ts_paint', 09:29:58 INFO - 'tpaint', 09:29:58 INFO - 'sessionrestore', 09:29:58 INFO - 'sessionrestore_no_auto_restore', 09:29:58 INFO - 'tabpaint']}, 09:29:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:29:58 INFO - 'ts_paint', 09:29:58 INFO - 'tpaint', 09:29:58 INFO - 'sessionrestore', 09:29:58 INFO - 'sessionrestore_no_auto_restore', 09:29:58 INFO - 'tabpaint']}, 09:29:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:29:58 INFO - 'tests': ['a11yr', 09:29:58 INFO - 'ts_paint', 09:29:58 INFO - 'tpaint', 09:29:58 INFO - 'sessionrestore', 09:29:58 INFO - 'sessionrestore_no_auto_restore', 09:29:58 INFO - 'tabpaint']}, 09:29:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:29:58 INFO - 'tests': ['a11yr', 09:29:58 INFO - 'ts_paint', 09:29:58 INFO - 'tpaint', 09:29:58 INFO - 'sessionrestore', 09:29:58 INFO - 'sessionrestore_no_auto_restore', 09:29:58 INFO - 'tabpaint']}, 09:29:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:29:58 INFO - 'tests': ['tsvgx', 09:29:58 INFO - 'tsvgr_opacity', 09:29:58 INFO - 'tart', 09:29:58 INFO - 'tscrollx', 09:29:58 INFO - 'cart']}, 09:29:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:29:58 INFO - 'tsvgr_opacity', 09:29:58 INFO - 'tart', 09:29:58 INFO - 'tscrollx', 09:29:58 INFO - 'cart']}, 09:29:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:58 INFO - 'talos_options': ['--disable-e10s'], 09:29:58 INFO - 'tests': ['tp5o']}, 09:29:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:58 INFO - 'tests': ['tp5o']}, 09:29:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:58 INFO - 'talos_options': ['--disable-e10s', 09:29:58 INFO - '--xperf_path', 09:29:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:29:58 INFO - 'tests': ['tp5n']}, 09:29:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:58 INFO - 'talos_options': ['--xperf_path', 09:29:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:29:58 INFO - 'tests': ['tp5n']}}, 09:29:58 INFO - 'talos.zip': {'path': '', 09:29:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:29:58 INFO - Running post-action listener: _resource_record_post_action 09:29:58 INFO - [mozharness: 2017-01-03 17:29:58.846741Z] Finished populate-webroot step (success) 09:29:58 INFO - [mozharness: 2017-01-03 17:29:58.846828Z] Running create-virtualenv step. 09:29:58 INFO - Running pre-action listener: _resource_record_pre_action 09:29:58 INFO - Running main action method: create_virtualenv 09:29:58 INFO - Creating virtualenv /builds/slave/test/build/venv 09:29:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:29:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:29:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:29:58 INFO - Using real prefix '/usr' 09:29:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:29:59 INFO - Installing distribute.............................................................................................................................................................................................done. 09:30:01 INFO - Installing pip.................done. 09:30:01 INFO - Return code: 0 09:30:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:30:01 INFO - Reading from file tmpfile_stdout 09:30:01 INFO - Output received: 09:30:01 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:30:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff953ffdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2f60>, '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 0x23a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a41d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:30:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:30:01 INFO - Using env: {'DISPLAY': ':0', 09:30:01 INFO - 'HOME': '/home/cltbld', 09:30:01 INFO - 'LANG': 'en_US.UTF-8', 09:30:01 INFO - 'LANGUAGE': 'en_US:en', 09:30:01 INFO - 'LOGNAME': 'cltbld', 09:30:01 INFO - 'MAIL': '/var/mail/cltbld', 09:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:01 INFO - 'MOZ_NO_REMOTE': '1', 09:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:01 INFO - 'NO_EM_RESTART': '1', 09:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:01 INFO - 'PWD': '/builds/slave/test', 09:30:01 INFO - 'SHELL': '/bin/bash', 09:30:01 INFO - 'SHLVL': '1', 09:30:01 INFO - 'TERM': 'linux', 09:30:01 INFO - 'TMOUT': '86400', 09:30:01 INFO - 'USER': 'cltbld', 09:30:01 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 09:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:01 INFO - '_': '/tools/buildbot/bin/python'} 09:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:30:01 INFO - Cleaning up... 09:30:01 INFO - Return code: 0 09:30:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff953ffdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2f60>, '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 0x23a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a41d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:30:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:30:01 INFO - Using env: {'DISPLAY': ':0', 09:30:01 INFO - 'HOME': '/home/cltbld', 09:30:01 INFO - 'LANG': 'en_US.UTF-8', 09:30:01 INFO - 'LANGUAGE': 'en_US:en', 09:30:01 INFO - 'LOGNAME': 'cltbld', 09:30:01 INFO - 'MAIL': '/var/mail/cltbld', 09:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:01 INFO - 'MOZ_NO_REMOTE': '1', 09:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:01 INFO - 'NO_EM_RESTART': '1', 09:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:01 INFO - 'PWD': '/builds/slave/test', 09:30:01 INFO - 'SHELL': '/bin/bash', 09:30:01 INFO - 'SHLVL': '1', 09:30:01 INFO - 'TERM': 'linux', 09:30:01 INFO - 'TMOUT': '86400', 09:30:01 INFO - 'USER': 'cltbld', 09:30:01 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 09:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:01 INFO - '_': '/tools/buildbot/bin/python'} 09:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:02 INFO - Downloading/unpacking psutil>=3.1.1 09:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:30:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:30:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:30:04 INFO - Installing collected packages: psutil 09:30:04 INFO - Running setup.py install for psutil 09:30:04 INFO - building 'psutil._psutil_linux' extension 09:30:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:30:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:30:04 INFO - building 'psutil._psutil_posix' extension 09:30:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:30:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:30:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:30:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:30:04 INFO - Successfully installed psutil 09:30:04 INFO - Cleaning up... 09:30:04 INFO - Return code: 0 09:30:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff953ffdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2f60>, '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 0x23a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a41d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:30:04 INFO - Using env: {'DISPLAY': ':0', 09:30:04 INFO - 'HOME': '/home/cltbld', 09:30:04 INFO - 'LANG': 'en_US.UTF-8', 09:30:04 INFO - 'LANGUAGE': 'en_US:en', 09:30:04 INFO - 'LOGNAME': 'cltbld', 09:30:04 INFO - 'MAIL': '/var/mail/cltbld', 09:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:04 INFO - 'MOZ_NO_REMOTE': '1', 09:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:04 INFO - 'NO_EM_RESTART': '1', 09:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:04 INFO - 'PWD': '/builds/slave/test', 09:30:04 INFO - 'SHELL': '/bin/bash', 09:30:04 INFO - 'SHLVL': '1', 09:30:04 INFO - 'TERM': 'linux', 09:30:04 INFO - 'TMOUT': '86400', 09:30:04 INFO - 'USER': 'cltbld', 09:30:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 09:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:04 INFO - '_': '/tools/buildbot/bin/python'} 09:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:30:07 INFO - Installing collected packages: mozsystemmonitor 09:30:07 INFO - Running setup.py install for mozsystemmonitor 09:30:07 INFO - Successfully installed mozsystemmonitor 09:30:07 INFO - Cleaning up... 09:30:07 INFO - Return code: 0 09:30:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:30: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')]} 09:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30: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')]} 09:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:07 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 0x7ff953ffdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2f60>, '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 0x23a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a41d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:30:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:30:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:30:07 INFO - Using env: {'DISPLAY': ':0', 09:30:07 INFO - 'HOME': '/home/cltbld', 09:30:07 INFO - 'LANG': 'en_US.UTF-8', 09:30:07 INFO - 'LANGUAGE': 'en_US:en', 09:30:07 INFO - 'LOGNAME': 'cltbld', 09:30:07 INFO - 'MAIL': '/var/mail/cltbld', 09:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:07 INFO - 'MOZ_NO_REMOTE': '1', 09:30:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:07 INFO - 'NO_EM_RESTART': '1', 09:30:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:07 INFO - 'PWD': '/builds/slave/test', 09:30:07 INFO - 'SHELL': '/bin/bash', 09:30:07 INFO - 'SHLVL': '1', 09:30:07 INFO - 'TERM': 'linux', 09:30:07 INFO - 'TMOUT': '86400', 09:30:07 INFO - 'USER': 'cltbld', 09:30:07 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 09:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:07 INFO - '_': '/tools/buildbot/bin/python'} 09:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:07 INFO - Downloading/unpacking jsonschema==2.5.1 09:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:30:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:09 INFO - Downloading functools32-3.2.3-2.tar.gz 09:30:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:30:09 INFO - warning: no files found matching '*.txt' 09:30:09 INFO - no previously-included directories found matching 'build' 09:30:09 INFO - no previously-included directories found matching 'dist' 09:30:09 INFO - no previously-included directories found matching '.git*' 09:30:09 INFO - Installing collected packages: jsonschema, functools32 09:30:09 INFO - Running setup.py install for functools32 09:30:09 INFO - warning: no files found matching '*.txt' 09:30:09 INFO - no previously-included directories found matching 'build' 09:30:09 INFO - no previously-included directories found matching 'dist' 09:30:09 INFO - no previously-included directories found matching '.git*' 09:30:09 INFO - Successfully installed jsonschema functools32 09:30:09 INFO - Cleaning up... 09:30:09 INFO - Return code: 0 09:30:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff953ffdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2f60>, '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 0x23a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a41d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:30:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:30:09 INFO - Using env: {'DISPLAY': ':0', 09:30:09 INFO - 'HOME': '/home/cltbld', 09:30:09 INFO - 'LANG': 'en_US.UTF-8', 09:30:09 INFO - 'LANGUAGE': 'en_US:en', 09:30:09 INFO - 'LOGNAME': 'cltbld', 09:30:09 INFO - 'MAIL': '/var/mail/cltbld', 09:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:09 INFO - 'MOZ_NO_REMOTE': '1', 09:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:09 INFO - 'NO_EM_RESTART': '1', 09:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:09 INFO - 'PWD': '/builds/slave/test', 09:30:09 INFO - 'SHELL': '/bin/bash', 09:30:09 INFO - 'SHLVL': '1', 09:30:09 INFO - 'TERM': 'linux', 09:30:09 INFO - 'TMOUT': '86400', 09:30:09 INFO - 'USER': 'cltbld', 09:30:09 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 09:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:09 INFO - '_': '/tools/buildbot/bin/python'} 09:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:30:10 INFO - Cleaning up... 09:30:10 INFO - Return code: 0 09:30:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:10 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 0x7ff953ffdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2f60>, '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 0x23a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a41d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:30:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:30:10 INFO - Using env: {'DISPLAY': ':0', 09:30:10 INFO - 'HOME': '/home/cltbld', 09:30:10 INFO - 'LANG': 'en_US.UTF-8', 09:30:10 INFO - 'LANGUAGE': 'en_US:en', 09:30:10 INFO - 'LOGNAME': 'cltbld', 09:30:10 INFO - 'MAIL': '/var/mail/cltbld', 09:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:10 INFO - 'MOZ_NO_REMOTE': '1', 09:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:10 INFO - 'NO_EM_RESTART': '1', 09:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:10 INFO - 'PWD': '/builds/slave/test', 09:30:10 INFO - 'SHELL': '/bin/bash', 09:30:10 INFO - 'SHLVL': '1', 09:30:10 INFO - 'TERM': 'linux', 09:30:10 INFO - 'TMOUT': '86400', 09:30:10 INFO - 'USER': 'cltbld', 09:30:10 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 09:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:10 INFO - '_': '/tools/buildbot/bin/python'} 09:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:10 INFO - Downloading/unpacking blobuploader==1.2.4 09:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:12 INFO - Downloading blobuploader-1.2.4.tar.gz 09:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:30:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:30:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:13 INFO - Downloading docopt-0.6.1.tar.gz 09:30:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:30:13 INFO - Installing collected packages: blobuploader, requests, docopt 09:30:13 INFO - Running setup.py install for blobuploader 09:30:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:30:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:30:13 INFO - Running setup.py install for requests 09:30:13 INFO - Running setup.py install for docopt 09:30:13 INFO - Successfully installed blobuploader requests docopt 09:30:13 INFO - Cleaning up... 09:30:13 INFO - Return code: 0 09:30:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff953ffdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2f60>, '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 0x23a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a41d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:30:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:30:13 INFO - Using env: {'DISPLAY': ':0', 09:30:13 INFO - 'HOME': '/home/cltbld', 09:30:13 INFO - 'LANG': 'en_US.UTF-8', 09:30:13 INFO - 'LANGUAGE': 'en_US:en', 09:30:13 INFO - 'LOGNAME': 'cltbld', 09:30:13 INFO - 'MAIL': '/var/mail/cltbld', 09:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:13 INFO - 'MOZ_NO_REMOTE': '1', 09:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:13 INFO - 'NO_EM_RESTART': '1', 09:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:13 INFO - 'PWD': '/builds/slave/test', 09:30:13 INFO - 'SHELL': '/bin/bash', 09:30:13 INFO - 'SHLVL': '1', 09:30:13 INFO - 'TERM': 'linux', 09:30:13 INFO - 'TMOUT': '86400', 09:30:13 INFO - 'USER': 'cltbld', 09:30:13 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 09:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:13 INFO - '_': '/tools/buildbot/bin/python'} 09:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:14 INFO - Running setup.py (path:/tmp/pip-TA1TPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:14 INFO - Running setup.py (path:/tmp/pip-9qBYZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:14 INFO - Running setup.py (path:/tmp/pip-FjeALe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:14 INFO - Running setup.py (path:/tmp/pip-giQBSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:14 INFO - Running setup.py (path:/tmp/pip-a_QBaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:14 INFO - Running setup.py (path:/tmp/pip-91ApJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:14 INFO - Running setup.py (path:/tmp/pip-N8Y674-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:14 INFO - Running setup.py (path:/tmp/pip-3O5_tK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:14 INFO - Running setup.py (path:/tmp/pip-8w9_ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:14 INFO - Running setup.py (path:/tmp/pip-izYtL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:14 INFO - Running setup.py (path:/tmp/pip-zXsMcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:14 INFO - Running setup.py (path:/tmp/pip-Z0GZ16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:14 INFO - Running setup.py (path:/tmp/pip-4eC8Mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:30:14 INFO - Running setup.py (path:/tmp/pip-ra0aUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:15 INFO - Running setup.py (path:/tmp/pip-ELU6AW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:30:15 INFO - Running setup.py (path:/tmp/pip-dooUqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:30:15 INFO - Running setup.py (path:/tmp/pip-txHGwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:30:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:30:15 INFO - Running setup.py install for manifestparser 09:30:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:30:15 INFO - Running setup.py install for mozcrash 09:30:15 INFO - Running setup.py install for mozdebug 09:30:15 INFO - Running setup.py install for mozdevice 09:30:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:30:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:30:15 INFO - Running setup.py install for mozfile 09:30:15 INFO - Running setup.py install for mozhttpd 09:30:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:30:15 INFO - Running setup.py install for mozinfo 09:30:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:30:15 INFO - Running setup.py install for mozInstall 09:30:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:30:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:30:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:30:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:30:16 INFO - Running setup.py install for mozleak 09:30:16 INFO - Running setup.py install for mozlog 09:30:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:30:16 INFO - Running setup.py install for moznetwork 09:30:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:30:16 INFO - Running setup.py install for mozprocess 09:30:16 INFO - Running setup.py install for mozprofile 09:30:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:30:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:30:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:30:16 INFO - Running setup.py install for mozrunner 09:30:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:30:16 INFO - Running setup.py install for mozscreenshot 09:30:16 INFO - Running setup.py install for moztest 09:30:16 INFO - Running setup.py install for mozversion 09:30:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:30:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:30:17 INFO - Cleaning up... 09:30:17 INFO - Return code: 0 09:30:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:17 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 0x7ff953ffdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2f60>, '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 0x23a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a41d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:30:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:30:17 INFO - Using env: {'DISPLAY': ':0', 09:30:17 INFO - 'HOME': '/home/cltbld', 09:30:17 INFO - 'LANG': 'en_US.UTF-8', 09:30:17 INFO - 'LANGUAGE': 'en_US:en', 09:30:17 INFO - 'LOGNAME': 'cltbld', 09:30:17 INFO - 'MAIL': '/var/mail/cltbld', 09:30:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:17 INFO - 'MOZ_NO_REMOTE': '1', 09:30:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:17 INFO - 'NO_EM_RESTART': '1', 09:30:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:17 INFO - 'PWD': '/builds/slave/test', 09:30:17 INFO - 'SHELL': '/bin/bash', 09:30:17 INFO - 'SHLVL': '1', 09:30:17 INFO - 'TERM': 'linux', 09:30:17 INFO - 'TMOUT': '86400', 09:30:17 INFO - 'USER': 'cltbld', 09:30:17 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 09:30:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:17 INFO - '_': '/tools/buildbot/bin/python'} 09:30:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:17 INFO - Running setup.py (path:/tmp/pip-cqpf69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:17 INFO - Running setup.py (path:/tmp/pip-PUGacA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:17 INFO - Running setup.py (path:/tmp/pip-SpHpDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:17 INFO - Running setup.py (path:/tmp/pip-l72T0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:17 INFO - Running setup.py (path:/tmp/pip-zwSuGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:17 INFO - Running setup.py (path:/tmp/pip-urpnFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:17 INFO - Running setup.py (path:/tmp/pip-52PDH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:17 INFO - Running setup.py (path:/tmp/pip-EOGStX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:17 INFO - Running setup.py (path:/tmp/pip-ycUqFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:17 INFO - Running setup.py (path:/tmp/pip-DfCclI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:18 INFO - Running setup.py (path:/tmp/pip-6GAGUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:18 INFO - Running setup.py (path:/tmp/pip-ystGrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:18 INFO - Running setup.py (path:/tmp/pip-KKtcMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:30:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:30:18 INFO - Running setup.py (path:/tmp/pip-ual4Gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:30:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:18 INFO - Running setup.py (path:/tmp/pip-wRewsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:30:18 INFO - Running setup.py (path:/tmp/pip-lI520u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:30:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:30:18 INFO - Running setup.py (path:/tmp/pip-5XbcRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:30:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:30:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:30:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:30:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:30:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:30:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:30:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:20 INFO - Downloading blessings-1.6.tar.gz 09:30:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:30:20 INFO - Installing collected packages: blessings 09:30:20 INFO - Running setup.py install for blessings 09:30:20 INFO - Successfully installed blessings 09:30:20 INFO - Cleaning up... 09:30:20 INFO - Return code: 0 09:30:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:30:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:30:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:30:21 INFO - Reading from file tmpfile_stdout 09:30:21 INFO - Current package versions: 09:30:21 INFO - argparse == 1.2.1 09:30:21 INFO - blessings == 1.6 09:30:21 INFO - blobuploader == 1.2.4 09:30:21 INFO - docopt == 0.6.1 09:30:21 INFO - functools32 == 3.2.3-2 09:30:21 INFO - jsonschema == 2.5.1 09:30:21 INFO - manifestparser == 1.1 09:30:21 INFO - mozInstall == 1.12 09:30:21 INFO - mozcrash == 1.0 09:30:21 INFO - mozdebug == 0.1 09:30:21 INFO - mozdevice == 0.48 09:30:21 INFO - mozfile == 1.2 09:30:21 INFO - mozhttpd == 0.7 09:30:21 INFO - mozinfo == 0.9 09:30:21 INFO - mozleak == 0.1 09:30:21 INFO - mozlog == 3.4 09:30:21 INFO - moznetwork == 0.27 09:30:21 INFO - mozprocess == 0.23 09:30:21 INFO - mozprofile == 0.28 09:30:21 INFO - mozrunner == 6.13 09:30:21 INFO - mozscreenshot == 0.1 09:30:21 INFO - mozsystemmonitor == 0.3 09:30:21 INFO - moztest == 0.8 09:30:21 INFO - mozversion == 1.4 09:30:21 INFO - psutil == 3.1.1 09:30:21 INFO - requests == 1.2.3 09:30:21 INFO - wsgiref == 0.1.2 09:30:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:21 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 0x7ff953ffdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2f60>, '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 0x23a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a41d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:30:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:30:21 INFO - Using env: {'DISPLAY': ':0', 09:30:21 INFO - 'HOME': '/home/cltbld', 09:30:21 INFO - 'LANG': 'en_US.UTF-8', 09:30:21 INFO - 'LANGUAGE': 'en_US:en', 09:30:21 INFO - 'LOGNAME': 'cltbld', 09:30:21 INFO - 'MAIL': '/var/mail/cltbld', 09:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:21 INFO - 'MOZ_NO_REMOTE': '1', 09:30:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:21 INFO - 'NO_EM_RESTART': '1', 09:30:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:21 INFO - 'PWD': '/builds/slave/test', 09:30:21 INFO - 'SHELL': '/bin/bash', 09:30:21 INFO - 'SHLVL': '1', 09:30:21 INFO - 'TERM': 'linux', 09:30:21 INFO - 'TMOUT': '86400', 09:30:21 INFO - 'USER': 'cltbld', 09:30:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 09:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:21 INFO - '_': '/tools/buildbot/bin/python'} 09:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:30:21 INFO - Cleaning up... 09:30:21 INFO - Return code: 0 09:30:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff953ffdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2f60>, '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 0x23a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a41d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:30:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:30:21 INFO - Using env: {'DISPLAY': ':0', 09:30:21 INFO - 'HOME': '/home/cltbld', 09:30:21 INFO - 'LANG': 'en_US.UTF-8', 09:30:21 INFO - 'LANGUAGE': 'en_US:en', 09:30:21 INFO - 'LOGNAME': 'cltbld', 09:30:21 INFO - 'MAIL': '/var/mail/cltbld', 09:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:21 INFO - 'MOZ_NO_REMOTE': '1', 09:30:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:21 INFO - 'NO_EM_RESTART': '1', 09:30:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:21 INFO - 'PWD': '/builds/slave/test', 09:30:21 INFO - 'SHELL': '/bin/bash', 09:30:21 INFO - 'SHLVL': '1', 09:30:21 INFO - 'TERM': 'linux', 09:30:21 INFO - 'TMOUT': '86400', 09:30:21 INFO - 'USER': 'cltbld', 09:30:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 09:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:21 INFO - '_': '/tools/buildbot/bin/python'} 09:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:30:21 INFO - Cleaning up... 09:30:21 INFO - Return code: 0 09:30:21 INFO - Running post-action listener: _resource_record_post_action 09:30:21 INFO - Running post-action listener: _start_resource_monitoring 09:30:21 INFO - Starting resource monitoring. 09:30:21 INFO - [mozharness: 2017-01-03 17:30:21.555806Z] Finished create-virtualenv step (success) 09:30:21 INFO - [mozharness: 2017-01-03 17:30:21.556376Z] Running install step. 09:30:21 INFO - Running pre-action listener: _resource_record_pre_action 09:30:21 INFO - Running main action method: install 09:30:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:30:21 INFO - Reading from file tmpfile_stdout 09:30:21 INFO - Detecting whether we're running mozinstall >=1.0... 09:30:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:30:21 INFO - Reading from file tmpfile_stdout 09:30:21 INFO - Output received: 09:30:21 INFO - Usage: mozinstall [options] installer 09:30:21 INFO - Options: 09:30:21 INFO - -h, --help show this help message and exit 09:30:21 INFO - -d DEST, --destination=DEST 09:30:21 INFO - Directory to install application into. [default: 09:30:21 INFO - "/builds/slave/test"] 09:30:21 INFO - --app=APP Application being installed. [default: firefox] 09:30:21 INFO - mkdir: /builds/slave/test/build/application 09:30:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:30:37 INFO - Reading from file tmpfile_stdout 09:30:37 INFO - Output received: 09:30:37 INFO - /builds/slave/test/build/application/firefox/firefox 09:30:37 INFO - Running post-action listener: _resource_record_post_action 09:30:37 INFO - [mozharness: 2017-01-03 17:30:37.783592Z] Finished install step (success) 09:30:37 INFO - [mozharness: 2017-01-03 17:30:37.783923Z] Running run-tests step. 09:30:37 INFO - Running pre-action listener: _resource_record_pre_action 09:30:37 INFO - Running main action method: run_tests 09:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:30:37 INFO - Python 2.7.3 09:30:37 INFO - Return code: 0 09:30:37 INFO - grabbing minidump binary from tooltool 09:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:37 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2f60>, '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 0x23a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a41d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:30:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:30:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:30:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:30:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:30:37 INFO - Return code: 0 09:30:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:30:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:30:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:30:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:30:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:30:37 INFO - Using env: {'DISPLAY': ':0', 09:30:37 INFO - 'HOME': '/home/cltbld', 09:30:37 INFO - 'LANG': 'en_US.UTF-8', 09:30:37 INFO - 'LANGUAGE': 'en_US:en', 09:30:37 INFO - 'LOGNAME': 'cltbld', 09:30:37 INFO - 'MAIL': '/var/mail/cltbld', 09:30:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:30:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:37 INFO - 'MOZ_NO_REMOTE': '1', 09:30:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:37 INFO - 'NO_EM_RESTART': '1', 09:30:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:37 INFO - 'PWD': '/builds/slave/test', 09:30:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:30:37 INFO - 'SHELL': '/bin/bash', 09:30:37 INFO - 'SHLVL': '1', 09:30:37 INFO - 'TERM': 'linux', 09:30:37 INFO - 'TMOUT': '86400', 09:30:37 INFO - 'USER': 'cltbld', 09:30:37 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135', 09:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:37 INFO - '_': '/tools/buildbot/bin/python'} 09:30:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:30:38 INFO - mozversion application_buildid: 20170103074820 09:30:38 INFO - mozversion application_changeset: 218db8b47b80de47bf6fe624aea9c545a3e01e4e 09:30:38 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:30:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:30:38 INFO - mozversion application_name: Firefox 09:30:38 INFO - mozversion application_remotingname: firefox-dev 09:30:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:30:38 INFO - mozversion application_vendor: Mozilla 09:30:38 INFO - mozversion application_version: 52.0a2 09:30:38 INFO - mozversion platform_buildid: 20170103074820 09:30:38 INFO - mozversion platform_changeset: 218db8b47b80de47bf6fe624aea9c545a3e01e4e 09:30:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:30:38 INFO - mozversion platform_version: 52.0a2 09:30:38 INFO - using testdate: 1483464638 09:30:38 INFO - actual date: 1483464638 09:30:38 INFO - starting webserver on 'localhost:55771' 09:30:38 INFO - SUITE-START | Running 2 tests 09:30:38 INFO - TEST-START | dromaeo_css 09:30:38 INFO - operating with platform_type : linux_ 09:30:38 INFO - Initialising browser for dromaeo_css test... 09:30:38 INFO - TEST-INFO | started process 7377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdzjW1_/profile http://localhost:55771/getInfo.html) 09:30:42 INFO - PROCESS | 7377 | __metrics Screen width/height:1600/1200 09:30:42 INFO - PROCESS | 7377 | colorDepth:24 09:30:42 INFO - PROCESS | 7377 | Browser inner width/height: 1024/697 09:30:42 INFO - PROCESS | 7377 | __metrics 09:30:43 ERROR - PROCESS | 7377 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 09:30:43 INFO - TEST-INFO | 7377: exit 0 09:30:43 INFO - Browser initialized. 09:30:43 INFO - Running cycle 1/1 for dromaeo_css test... 09:30:43 INFO - TEST-INFO | started process 7508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdzjW1_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:30:55 INFO - PROCESS | 7508 | RSS: Main: 151916544 09:30:55 INFO - PROCESS | 7508 | 09:31:45 INFO - PROCESS | 7508 | 1483464705326 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:33:56 INFO - PROCESS | 7508 | Cycle 1(1): loaded http://localhost:55771/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55771/tests/dromaeo/cssquery-ext.html) 09:33:57 INFO - PROCESS | 7508 | RSS: Main: 156659712 09:33:57 INFO - PROCESS | 7508 | 09:36:59 INFO - PROCESS | 7508 | Cycle 1(1): loaded http://localhost:55771/tests/dromaeo/cssquery-ext.html (next: http://localhost:55771/tests/dromaeo/cssquery-jquery.html) 09:36:59 INFO - PROCESS | 7508 | RSS: Main: 153489408 09:36:59 INFO - PROCESS | 7508 | 09:40:01 INFO - PROCESS | 7508 | Cycle 1(1): loaded http://localhost:55771/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55771/tests/dromaeo/cssquery-mootools.html) 09:40:02 INFO - PROCESS | 7508 | RSS: Main: 153632768 09:40:02 INFO - PROCESS | 7508 | 09:43:03 INFO - PROCESS | 7508 | Cycle 1(1): loaded http://localhost:55771/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55771/tests/dromaeo/cssquery-prototype.html) 09:43:04 INFO - PROCESS | 7508 | RSS: Main: 152178688 09:43:04 INFO - PROCESS | 7508 | 09:46:07 INFO - PROCESS | 7508 | Cycle 1(1): loaded http://localhost:55771/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55771/tests/dromaeo/cssquery-yui.html) 09:46:07 INFO - PROCESS | 7508 | RSS: Main: 154189824 09:46:07 INFO - PROCESS | 7508 | 09:49:09 INFO - PROCESS | 7508 | Cycle 1(1): loaded http://localhost:55771/tests/dromaeo/cssquery-yui.html (next: http://localhost:55771/tests/dromaeo/cssquery-dojo.html) 09:49:10 INFO - PROCESS | 7508 | RSS: Main: 155578368 09:49:10 INFO - PROCESS | 7508 | 09:49:10 INFO - PROCESS | 7508 | __start_tp_report 09:49:10 INFO - PROCESS | 7508 | _x_x_mozilla_page_load 09:49:10 INFO - PROCESS | 7508 | _x_x_mozilla_page_load_details 09:49:10 INFO - PROCESS | 7508 | |i|pagename|runs| 09:49:10 INFO - PROCESS | 7508 | |0;dojo.html;3246.4318744219763;3275.967240327596;3286;3295.7857739246947;3298.290867463495;5522.088855338864;5567.916481252784;5583.190437386582;5620.943790562098;5621.915671264935;5627.577931655122;5691.08942569189;5698.316202055748;5724.656520608766;5785.305763308398;5136.409312929014;5179.870503237412;5202.193659982709;5209.791608335662;5215.739213039352;5239.5546378557865;5249.396319423277;5258.842234732964;5259.289995850569;5266.052110620087;5010.799568017275;5023.874403139914;5226.216067589854;5231.2153177023565;5246.973765131169;5091.338126043609;5095.8980820383385;5101.438841727407;5126.71803050832;5146.6911985281;5105.5149760772665;5112.923306150411;5137.17805151174;5184.092783762826;5255.1329030709885;5446.7276636168035;5658.8019419320535;5688.061469857468;5736.8852622947725;5739.311282646109;5871.9412805871825;5948.881022379572;5964.582479226456;5967.224260846106;5968.582199246054;5988.880222395528;6032.215811944463;6038.124471951586;6039.335673075958;6058.606190597597;5443.510084092451;5560.4161563036105;5612.494875461187;5623.184638227434;5632.408597097327;6077.088436734525;6082.665453400105;6084.847878802977;6093.573449858467;6102.877942441126;5827;5828.038373668297;5862.091375836752;5867.031939729982;5892.057270836645;5848.385919478478;5873.970630146822;5892.911606325909;5897.498712609477;5975.52195824333;5865.824025279163;5874.353821079678;5889.411058894077;5894.440028197314;5895.852603684943;5772.538196944234;5852.678102704393;5914.349421563625;5922.141289512996;5955.7617695292565;4541.9545804542195;4552.954470455253;4555.271156614992;4573.977130114395;4617.238155704271;4075.1238483726142;4079.6124368184974;4080.3063479208604;4101.52832424269;4141.64795992338;5786.479216870502;5802.158686990363;5807.041838096751;5809.854753631109;5842.853928651818;5765.1928729977835;5802.1296805479515;5920.37836027211;5948.762049518057;5974.074018527135;5809.564282678732;5815.302163740378;5819.679917604488;5820.679862607512;5842.357340692521;5200.7919683213;5212.009718153615;5226.790928362823;5231.555317797954;5266.1574148136115;6126.632402055891;6159.722812473449;6185.969070154711;6191.288001879841;6248.250209974832;6010.188624535806;6063.878722425615;6073.787417440369;6074.757009719562;6130.049842274455;6225.470834979077;6265.874682506415;6282.780102696383;6295.055741638791;6329.050642403492;5777.884442311214;5823.4467725566;5857.941420585739;5954.612950158225;5965.198015597486;5968.373320801254;5986.551008674454;5988.461038506555;5997.850053748692;6078.513718902389;5833.9416605835095;5862.472377486047;5902.085176797603;5904.3210030847;5915.083162109708;5626.240457538343;5723.771049157987;5923.437273459014;5929.288485381781;5943.286805583358;5773.53811695055;5808.76764929415;5832;5874.206982057368;5892.410758924073;5939.287285525765;5951.166836642787;5962.821115366546;5969.194158788508;5975.462208401264;5548.528375088163;5587.552995760248;5647.181158731879;5825.825225243249;5841.474267315962 09:49:10 INFO - PROCESS | 7508 | |1;ext.html;569.7777866632014;616.2112496005112;636.3159603426318;662.4071456046835;669.1434963247045;43536;44694.329585056206;44779.55220447794;47801;47892.52107478924;45961.77019114908;46245.537544624545;46451;46458.53541464584;46675.533244667546;8758.167974042472;8855.291576673852;8875.644974201025;8889.73330800077;8920.375573709844;8734;8834.734957951272;8848;8895.866562001544;8917.68788092417;8814.86777698335;8915.465072095663;8915.732528024137;8932.46405215689;8956.059613740561;8754.080821513713;8822.382433229677;8861;8871.290296776275;8945.418547794405;8636.481811091355;8647.827043459158;8660.48037117775;8684.175003374668;8725.694600689008;42704.57295427037;43502.12995740068;43697.563024369665;44076.3388549172;44098.11803763907;3428.108691740141;3482.9477557836653;3516.472529120627;3650.0874781304674;4072.3077076897;33308.33383332344;33373.16567085818;33614.49578256328;33864.83067584646;34699.13252168691;4017.13631569214;4086.7956602169775;4156.709030367875;4174.269502836992;4189.895252618679;341013;341532;342926;345611.2719436412;348526;59187;59327.70336148292;59421.405785941584;59552.404475955555;59861.40138598646;61918.0712289316;61977;62067.689661551405;62219;62302.37697623057;17551.824481755273;17794.37719679805;17830.821691783174;17836.643267134583;17837.46487605374;14231.50189743354;14304.284785760878;14341.713165736626;14343.92828035874;14361.856381436051;16326.83673163277;16591;16658.16709164537;16676.916615416845;16677.583060423585;5915.822525324247;5982.850428739229;5991.2510936132985;6066.969665151646;6194.473469755121;1033.4367769565604;1046.8011077895328;1078.7464945737902;1130.9547618095348;1147.4893672315907;32498.83750581232;32851.1787205317;33032;33044.66955330464;33955.83022084874;1170.2334970594275;1171.5782318365382;1176.5470293936726;1204.6988252936767;1228.0666693313146;17141.657166856592;17372.565685857702;17437.47687569375;17512.64974700524;17622.207000685;484246;484664;486277;488243;489732;60226.397736022955;60408.395916040274;60458.39541604616;60741.39258607446;60755;1384.6815232496583;1404.5294826233326;1438.3024233247077;1438.7626041703002;1444.0469290268372;31386.843065784524;32907.50638740469;33138.33723325568;33615.495767563996;34028.65971340255;53181;53445.46554534405;53617.46382536281;53769;53949;422959;423018;423734;424303;425521;42546;42914.35628465513;43052.78473607612;43220.78389608032;43303.35044974265;47908.5209147918;48548.27177592268;48562.514374857215;50013.249801252285;50564.74717626388;41323.380149298384;41897.37153942632;42079;42835.14329713326;44059.33910991273;41483;41847.79076104722;42729.35905961351;43796.56203437925;43870;41454.585454145075;41804.3729344054;42747.35878961756;43162.1367572653;43174;36742.26515469622;38233.80883095567;38576.42135368028;39087.6091239084;39213.60786392214;28970.42059158847;29152.396618185354;29391.26521836971;29470.263243419085;29489 09:49:10 INFO - PROCESS | 7508 | |2;jquery.html;415.9625633692971;416.33802254415474;419.55317586770093;422.8942764308922;439.8130794412374;18124.90937545312;19438.31965881196;19729.605407891835;19875.304364347252;19916.800831991713;18995.81004189958;19043.904780476078;19650;19665;19779.30772422962;5524.696141712194;5837.474627283544;5896.852578685524;5898.587098903078;5901.20333754944;5656.91514627281;5830.970845145768;5843.883122337551;5876.647401155923;5884.558658100638;5892.734826932777;6007.429294217064;6022.8795424091495;6023.518118550505;6034.939650603482;5453.318335208099;5503.3395992480755;5685.8578535536735;5991.071383935497;6036.5170786336985;5303.787848486056;5349.117395629716;5353.411124776271;5363.973180134074;5374.140137578008;14841;22135.225267115573;22648.43378915524;22970.54058918829;23827.166049188196;2331.75516570761;2342.7422983471806;2423.4547226873988;2461.8030557555353;2961.4077184563175;10409.583616655325;10794.298370605886;11038.227324087316;11294.152938529644;11427.257228280136;1839.6596629623562;1894.943151705451;1897.601503684228;1925.7592800899888;1957.559549101455;84452.57773711154;89371.55314223452;90050.5497472515;91114;92796;11375.943120284346;11505.252158609663;11771.823422648667;11832.70418239551;11905.345206013579;16902.070386128635;16969;16988.06565638902;17046.403375881786;17082.572935676708;8581.828363432696;8623.094575069654;8657.567121644019;8738.91261087381;8770.868436973451;8223.05434874997;8269.586520673942;8445.282151017109;8453.704120355758;8453.788655283666;4915.975420122876;5024.748762561857;5037.546620804145;5076.670016448919;5165.586753059746;2021.181421524285;2128.9893550532456;2148.742150941897;2161.1679503391306;2211.2150186683816;934.2946075712794;960.3661583355092;1028.377831412;1036.9688909332733;1049;19483.85420829661;19710.70433943492;19911.303104391565;20008.59982800336;20008.69986950197;979.6522234606755;991.9752006199902;993.438707130469;1014.5485259059648;1045.6967479431032;11049.723756906142;11105.611303604335;11222.887771122347;11235.775284494264;11252.212345135926;472060;473092;473852;478727;486065;57055;57343.71328143332;59065;99766;100931;1003.418017549834;1044.1751016696724;1060.5492665617082;1069.2034434346306;1071.2929466552039;17802.198901049742;18203.45389638313;18394.81605183931;18413.26346946107;18452.354167604608;44560.33159502675;45345;45475.54524454713;45602.31596526121;46309;64413.71172576428;65030.674846625465;65474.345256546825;65666.34333656602;67022.3297767016;8770.517621530877;8997.64009439615;9141.954290228772;9151.771205719644;9191;10531.684049478528;13308.86691133115;13369.331533423096;13673.86326136726;13971.30143492801;11460.541578336773;11550.133739969368;11759.118541033393;11935.045196384443;12002.819957700816;11833.349165795964;12015.45930433115;12102.273863568214;12181.87818121843;12184.390780460764;12277.938610306892;12366.876331236932;12477.001839852972;12754.234745915275;12817.423215955117;7690.692372305045;8879.644814207617;9048.457092574467;9112.726618201465;9130.086991300817;11158.274712143684;12216.938915305367;12304.354563768833;12312.692182695504;12450.501979920702 09:49:10 INFO - PROCESS | 7508 | |3;mootools.html;1487.3455679501021;1494.970100597988;1637.4678229575384;1771.927983569941;1772.9822701772978;7716.112647045591;7933.0876949150725;8065.233802788733;8680.869786953193;8710.172533609304;8561.61472733727;8835.337349698782;8838.46969181848;9068.41055331403;9099.818003639923;2409.602415601428;2440.7437219092008;2444.4133407982135;2450.705915290159;2457.4716435966266;2448.4054378405986;2551.5279673260507;2561.602951542505;2570.473053024135;2575.214559559334;2491.9750802491926;2498.038255271724;2521.155412936668;2524.3184340228217;2526.936826579341;2446.376174075608;2466.124525793344;2471.209213051824;2482.354587807165;2490.1657944588583;2432.0636554926305;2439.6706444630104;2451.252368027751;2454.104251948026;2486.5151295497385;8985.966613839426;9006.86489702655;9014.098590140933;9050.77373065672;9065.184133427958;5498.532624726903;5523.28197334344;5576.832695019156;5625.240592520039;5649.265595472603;3493.0917961330238;3493.1616412061176;3518.0677120563073;3539.150603855082;3594.4608308753636;1128.458339996798;1144.0790163918043;1146.6789298996293;1155.8497395338636;1175.1891195075457;12294.877051229463;12335.198212116184;12440.19138755978;12450.813237801349;12480.313582752944;4605.562471565196;4650.906981860344;4730.337752714623;4843.2735089736825;4956.677815941952;9587.664431744995;9739.805203895883;9771.902280977241;9798.951005245071;9803.264755143393;5292.364916210003;5305.840824775263;5575.275214222206;5734.197212390269;5736.483716465538;4537.909241815145;4766.475687674353;5121.385433747974;5162.6128040397125;5232.3459567554055;4104.302268614343;4112.663110702576;4179.91640167195;4218.704690671685;4234.830606775756;1361.4282001559368;1384.3631929312628;1388.5348408283137;1392.262101086426;1394.5816255123423;918.3663272342196;980.3774603127066;990.0050449298553;1017.5777052523268;1029.341221618165;5912.260967379078;6205.844853878689;6236.594621349688;6240.656763878031;6291.4023167799905;460.7350773305363;462.26269100784197;470.3931927813151;510.99233511497357;511.1872123323933;4174.248635245685;4188.81150348235;4301.483821941387;4353.34699795027;4354.869353919387;9983.600655973825;10272.33229840058;10284.948575257076;10336;10340.948295258626;10234.846477302846;10237.078662920372;10285.7428564285;10316.27786054969;10319.948400258101;7907.762767116996;8142.307903828241;8420.031696354876;8470.618822153017;8597.742067738103;5893.6463812171405;6023.909641355295;6036.426539478743;6097.298810636834;6118.174046503665;10262.332948358333;10354.223433242687;10406.375617462976;10466.63366782159;10497.685069447929;10307.330023548446;10351.223658225512;10364.585416583252;10517.316374435637;10538.156947444033;7697.345725613161;7917.049954005326;7969.362451004022;7989.400794940519;8066.798330041796;8595.87106193395;8766.123387661182;8859.202671759573;8876.378653494452;8890.73327800167;7404.925950740424;7432.962835185789;7596.278353556403;7779.37764978789;7831.8825217622925;7545;7701.6534255957495;7725.575093369918;7792.883106753517;7887.290143887078;7187.281271872771;7310.817229569303;7321;7327.816804579928;7491.513051651626;5386.676799392049;5433.673979561239;5536.058869992031;5545.473180047889;5561.833145005657;5418.647787893774;5442.238086667949;5469.72651367438;5491.505764481056;5521.613487055867 09:49:10 INFO - PROCESS | 7508 | |4;prototype.html;340.68997212536595;349.8215909885958;355.31933952405126;356.9964300356999;357.9319929213448;5565.609517310944;5632.5212356949605;5643.774249030044;5665.603407761459;5667;5581.2186293918885;5587.7485513151905;5607.719614019303;5608.663480191191;5616.691081990499;4271.786410679453;4418.381426600278;4421.535738747433;4446.444194475691;4453.3097369907555;4361.912761744763;4434.534373890743;4436;4450.57719516647;4451.955480445203;4383.561643835606;4402.2516172250635;4407.713498622596;4428.114377124572;4434.578715022068;4429.291313389858;4441.556494139385;4445.644348452132;4450.132224216279;4454.933176002362;3854.1135538825947;3893.435451859493;3909.491766070421;3923.862664806718;3927.1360300734077;5406.864828379283;5412.675239485604;5454.481824226692;5476.726163691839;5501.202325662796;5000.999600159928;5002.849914502571;5005.6996580205305;5010.72441015744;5023.196288593807;5677.205191273225;5877.324107727623;5879.1475236090955;5884.352721200665;5886.911696324559;4263.360495925605;4277.358396240589;4324.329728892027;4327.567243275679;4337.067530480962;5961.314448838352;6131.294901086388;6182.350853160398;6223;6243.56295059346;4264.445622069174;4288.2281189385585;4302.956970430256;4305.83742389553;4320.567943205717;4297.9255186203445;4313.309870420718;4324.545922678137;4356.956430435655;4358.607725304738;4864.246041863516;4968.726720030433;5021.924671129936;5024.221245706921;5027.949720502821;5855.394349514425;5899.941000589939;5915.970420147958;5918.822435326947;5918.852028699231;1449.9492517761828;1466.7359875222348;1466.9853301466849;1484.5101116631702;1486.8661820435996;973.6154219083422;1010.7618167744602;1012.9949350253202;1020.806046851096;1030.3611760708409;5513.696746678891;5555.111182210827;5560.666360018412;5565.193047008162;5621.297337832771;5865.765369385262;5872.265966754156;5872.618279811884;5885.733417953077;5898.4101589840675;5434.592405569598;5529.723513824292;5594.748236329375;5615.634983726045;5671.461211184931;3057.7095175958248;3114.299282661383;3118.610173728284;3125.3436778276364;3130.8591113399953;5888.234529511136;6085.665288409092;6175.722092505848;6184.907226391608;6241.906371404432;5872.412758724094;5898.168878938133;5921.881562368729;5926.585139040312;5937.584369094122;6072.878542429126;6123.724432400552;6128.540359472968;6188.2883468400805;6197.070439434031;5630.4369563043365;5681.65910045382;5773.6824474654295;5823.4467725566;5860.912086318624;5688.752942587572;5722.284714410699;5786.594938354275;5788.479036886532;5811.651300921789;6165.229346331708;6403.551751377358;6406.679666016587;6420.646864422315;6420.775272865428;4329.809302441728;4339.652827773833;4347.500037495602;4369.868903932887;4369.956300436955;5968.552358573038;6107.970071244661;6111.449969502766;6161.888246435521;6216.347283535164;5903.321118071305;5928.199693041384;5934.376890426443;5941.494972927349;5948.078047902582;5907.143464197753;5910.940890591211;5923.4076592340425;5928.34788173292;5941.37615550361;5696.686682232517;5822.475977162076;5875.970620146872;5884.617499862496;5919.763209471573;5877.882442351214;5957.106434034929;5967.403259673998;5983.952808258625;6021.849453763516;5700.572457065654;5799.317433429718;5799.884002320015;5821.079043915583;5823.242978412779 09:49:10 INFO - PROCESS | 7508 | |5;yui.html;735.5476382025056;756.2626439221759;784.901887264092;795.5902710104295;912.0879120879118;14841.703165936675;16023.839761602381;16174.2721577529;16273.267702953366;16280.185990700476;12946.805797913039;13000.609981700563;13245.271510066943;13695.383707733152;13726.176429414241;843.4854738609458;860.4450129666361;864.0970186155482;865.3596338709341;865.8311629232302;834.3492076180559;838.714836955435;858.6222062292602;858.7767180533075;859.072202021815;895.4985208283382;899.2626046641757;904.3759805734055;904.430208968349;907.1608761895253;890.6526454682679;890.679355432044;891.131147131548;892.2371372476537;892.3887137310962;657.4149007383432;660.7125900233414;662.7912207654573;664.6178447392721;665.527475492401;15261.694766104727;15279.388824447009;15476.845231547653;15532.145731984849;15634.296456659364;13537.661558461019;14388.92805535976;14689.632759180999;15042.32309546073;15129.848701513065;11209.551617935273;11500.194986350958;11664.591739289084;11758.17692761507;11762.705932351673;3576.2489877125836;3612.277544491112;3749.643783840531;3798.601146879593;3834.65488106069;63196.052059219146;65260.34739652638;66001;66106.3389366105;67653.3234667652;11095.1123910087;11124.55501779936;11225.94387028076;11280.717982050515;11461.770764584662;20212.797872021387;20267;20583;20820.895895520425;20833.270835520987;8046.235607617267;8223.629936652866;8266.8346633067;8268.131846156188;8427.662893484192;4505.121501307213;4664.416947881515;4698.342232087511;4742.905141897143;4844.8304309349705;3604.747667663238;3773.0755964788805;3776.074861658856;3776.131489757371;3777.697784177259;624.7938180400457;628.5505863307757;635.383677832511;640.8718256348656;658.4732214228694;747.1072068877747;764.5183534373309;785.1951749456738;797.5613412623034;809.1382677448498;9661.71014869541;9669.661561845302;9764.365316254421;9792.902070979342;9946;649.6004956951441;720.8089856188114;755.7543798265476;763.3435245688703;764.170874601053;4388.144311859157;4715.669903106818;4742.454617719007;4950.426402274143;4991.785227391921;86047;86119;87860;90942.54528727314;92475;82804;82971.5851420739;83609;83680.27142999774;86114;74371.25628743644;74634;75127;75255.62372188213;75313.6234318814;9934.552945117632;10173.135283500986;10248.128909042814;10276.743081422725;10359.32664376813;47322.76338618285;47639;47938.760306198245;48045.5195448055;49694;63448.36551634609;64217;65545.67227163834;66312;68256.31743682499;12477.812832807334;12985.220886746825;13041.282729449971;13056.412461439448;13556.983226258268;14427.639309017359;14431.639209019859;14591;14637.92681036588;14781.852181478047;12963.611091667264;12968.610941671765;12996.935015324863;13341.599752007067;13904.304784760923;13771.517996870462;14053.718925621635;14168.362423690753;14444.638884027983;14535.563933082025;12610.306433145897;12804.231746095264;12902.419391127234;13222.074454788073;13511.256880871253;10272.691819245434;10817.45912704346;10984.835227471754;10986.670399888017;11087.168462365193;11553.480093395985;11879.643610691694;11890.464929078385;12000.879991199976;12198.512059517874 09:49:10 INFO - PROCESS | 7508 | __end_tp_report 09:49:10 INFO - PROCESS | 7508 | __start_cc_report 09:49:10 INFO - PROCESS | 7508 | _x_x_mozilla_cycle_collect,317 09:49:10 INFO - PROCESS | 7508 | __end_cc_report 09:49:10 INFO - PROCESS | 7508 | __startTimestamp1483465750243__endTimestamp 09:49:10 INFO - PROCESS | 7508 | 09:49:10 INFO - PROCESS | 7508 | ------- Summary: start ------- 09:49:10 INFO - PROCESS | 7508 | Number of tests: 6 09:49:10 INFO - PROCESS | 7508 | 09:49:10 INFO - PROCESS | 7508 | [#0] dojo.html Cycles:165 Average:5583.64 Median:5819.68 stddev:617.24 (10.6%) stddev-sans-first:591.27 09:49:10 INFO - PROCESS | 7508 | Values: 3246.4 3276.0 3286.0 3295.8 3298.3 5522.1 5567.9 5583.2 5620.9 5621.9 5627.6 5691.1 5698.3 5724.7 5785.3 5136.4 5179.9 5202.2 5209.8 5215.7 5239.6 5249.4 5258.8 5259.3 5266.1 5010.8 5023.9 5226.2 5231.2 5247.0 5091.3 5095.9 5101.4 5126.7 5146.7 5105.5 5112.9 5137.2 5184.1 5255.1 5446.7 5658.8 5688.1 5736.9 5739.3 5871.9 5948.9 5964.6 5967.2 5968.6 5988.9 6032.2 6038.1 6039.3 6058.6 5443.5 5560.4 5612.5 5623.2 5632.4 6077.1 6082.7 6084.8 6093.6 6102.9 5827.0 5828.0 5862.1 5867.0 5892.1 5848.4 5874.0 5892.9 5897.5 5975.5 5865.8 5874.4 5889.4 5894.4 5895.9 5772.5 5852.7 5914.3 5922.1 5955.8 4542.0 4553.0 4555.3 4574.0 4617.2 4075.1 4079.6 4080.3 4101.5 4141.6 5786.5 5802.2 5807.0 5809.9 5842.9 5765.2 5802.1 5920.4 5948.8 5974.1 5809.6 5815.3 5819.7 5820.7 5842.4 5200.8 5212.0 5226.8 5231.6 5266.2 6126.6 6159.7 6186.0 6191.3 6248.3 6010.2 6063.9 6073.8 6074.8 6130.0 6225.5 6265.9 6282.8 6295.1 6329.1 5777.9 5823.4 5857.9 5954.6 5965.2 5968.4 5986.6 5988.5 5997.9 6078.5 5833.9 5862.5 5902.1 5904.3 5915.1 5626.2 5723.8 5923.4 5929.3 5943.3 5773.5 5808.8 5832.0 5874.2 5892.4 5939.3 5951.2 5962.8 5969.2 5975.5 5548.5 5587.6 5647.2 5825.8 5841.5 09:49:10 INFO - PROCESS | 7508 | 09:49:10 INFO - PROCESS | 7508 | [#1] ext.html Cycles:180 Average:59486.18 Median:42791.25 stddev:111415.92 (260.4%) stddev-sans-first:111640.66 09:49:10 INFO - PROCESS | 7508 | Values: 569.8 616.2 636.3 662.4 669.1 43536.0 44694.3 44779.6 47801.0 47892.5 45961.8 46245.5 46451.0 46458.5 46675.5 8758.2 8855.3 8875.6 8889.7 8920.4 8734.0 8834.7 8848.0 8895.9 8917.7 8814.9 8915.5 8915.7 8932.5 8956.1 8754.1 8822.4 8861.0 8871.3 8945.4 8636.5 8647.8 8660.5 8684.2 8725.7 42704.6 43502.1 43697.6 44076.3 44098.1 3428.1 3482.9 3516.5 3650.1 4072.3 33308.3 33373.2 33614.5 33864.8 34699.1 4017.1 4086.8 4156.7 4174.3 4189.9 341013.0 341532.0 342926.0 345611.3 348526.0 59187.0 59327.7 59421.4 59552.4 59861.4 61918.1 61977.0 62067.7 62219.0 62302.4 17551.8 17794.4 17830.8 17836.6 17837.5 14231.5 14304.3 14341.7 14343.9 14361.9 16326.8 16591.0 16658.2 16676.9 16677.6 5915.8 5982.9 5991.3 6067.0 6194.5 1033.4 1046.8 1078.7 1131.0 1147.5 32498.8 32851.2 33032.0 33044.7 33955.8 1170.2 1171.6 1176.5 1204.7 1228.1 17141.7 17372.6 17437.5 17512.6 17622.2 484246.0 484664.0 486277.0 488243.0 489732.0 60226.4 60408.4 60458.4 60741.4 60755.0 1384.7 1404.5 1438.3 1438.8 1444.0 31386.8 32907.5 33138.3 33615.5 34028.7 53181.0 53445.5 53617.5 53769.0 53949.0 422959.0 423018.0 423734.0 424303.0 425521.0 42546.0 42914.4 43052.8 43220.8 43303.4 47908.5 48548.3 48562.5 50013.2 50564.7 41323.4 41897.4 42079.0 42835.1 44059.3 41483.0 41847.8 42729.4 43796.6 43870.0 41454.6 41804.4 42747.4 43162.1 43174.0 36742.3 38233.8 38576.4 39087.6 39213.6 28970.4 29152.4 29391.3 29470.3 29489.0 09:49:10 INFO - PROCESS | 7508 | 09:49:10 INFO - PROCESS | 7508 | [#2] jquery.html Cycles:180 Average:28922.79 Median:2337.25 stddev:78662.09 (3365.6%) stddev-sans-first:78853.64 09:49:10 INFO - PROCESS | 7508 | Values: 416.0 416.3 419.6 422.9 439.8 18124.9 19438.3 19729.6 19875.3 19916.8 18995.8 19043.9 19650.0 19665.0 19779.3 5524.7 5837.5 5896.9 5898.6 5901.2 5656.9 5831.0 5843.9 5876.6 5884.6 5892.7 6007.4 6022.9 6023.5 6034.9 5453.3 5503.3 5685.9 5991.1 6036.5 5303.8 5349.1 5353.4 5364.0 5374.1 14841.0 22135.2 22648.4 22970.5 23827.2 2331.8 2342.7 2423.5 2461.8 2961.4 10409.6 10794.3 11038.2 11294.2 11427.3 1839.7 1894.9 1897.6 1925.8 1957.6 84452.6 89371.6 90050.5 91114.0 92796.0 11375.9 11505.3 11771.8 11832.7 11905.3 16902.1 16969.0 16988.1 17046.4 17082.6 8581.8 8623.1 8657.6 8738.9 8770.9 8223.1 8269.6 8445.3 8453.7 8453.8 4916.0 5024.7 5037.5 5076.7 5165.6 2021.2 2129.0 2148.7 2161.2 2211.2 934.3 960.4 1028.4 1037.0 1049.0 19483.9 19710.7 19911.3 20008.6 20008.7 979.7 992.0 993.4 1014.5 1045.7 11049.7 11105.6 11222.9 11235.8 11252.2 472060.0 473092.0 473852.0 478727.0 486065.0 57055.0 57343.7 59065.0 99766.0 100931.0 1003.4 1044.2 1060.5 1069.2 1071.3 17802.2 18203.5 18394.8 18413.3 18452.4 44560.3 45345.0 45475.5 45602.3 46309.0 64413.7 65030.7 65474.3 65666.3 67022.3 8770.5 8997.6 9142.0 9151.8 9191.0 10531.7 13308.9 13369.3 13673.9 13971.3 11460.5 11550.1 11759.1 11935.0 12002.8 11833.3 12015.5 12102.3 12181.9 12184.4 12277.9 12366.9 12477.0 12754.2 12817.4 7690.7 8879.6 9048.5 9112.7 9130.1 11158.3 12216.9 12304.4 12312.7 12450.5 09:49:10 INFO - PROCESS | 7508 | 09:49:10 INFO - PROCESS | 7508 | [#3] mootools.html Cycles:180 Average:5870.25 Median:2733.84 stddev:3232.17 (118.2%) stddev-sans-first:3224.46 09:49:10 INFO - PROCESS | 7508 | Values: 1487.3 1495.0 1637.5 1771.9 1773.0 7716.1 7933.1 8065.2 8680.9 8710.2 8561.6 8835.3 8838.5 9068.4 9099.8 2409.6 2440.7 2444.4 2450.7 2457.5 2448.4 2551.5 2561.6 2570.5 2575.2 2492.0 2498.0 2521.2 2524.3 2526.9 2446.4 2466.1 2471.2 2482.4 2490.2 2432.1 2439.7 2451.3 2454.1 2486.5 8986.0 9006.9 9014.1 9050.8 9065.2 5498.5 5523.3 5576.8 5625.2 5649.3 3493.1 3493.2 3518.1 3539.2 3594.5 1128.5 1144.1 1146.7 1155.8 1175.2 12294.9 12335.2 12440.2 12450.8 12480.3 4605.6 4650.9 4730.3 4843.3 4956.7 9587.7 9739.8 9771.9 9799.0 9803.3 5292.4 5305.8 5575.3 5734.2 5736.5 4537.9 4766.5 5121.4 5162.6 5232.3 4104.3 4112.7 4179.9 4218.7 4234.8 1361.4 1384.4 1388.5 1392.3 1394.6 918.4 980.4 990.0 1017.6 1029.3 5912.3 6205.8 6236.6 6240.7 6291.4 460.7 462.3 470.4 511.0 511.2 4174.2 4188.8 4301.5 4353.3 4354.9 9983.6 10272.3 10284.9 10336.0 10340.9 10234.8 10237.1 10285.7 10316.3 10319.9 7907.8 8142.3 8420.0 8470.6 8597.7 5893.6 6023.9 6036.4 6097.3 6118.2 10262.3 10354.2 10406.4 10466.6 10497.7 10307.3 10351.2 10364.6 10517.3 10538.2 7697.3 7917.0 7969.4 7989.4 8066.8 8595.9 8766.1 8859.2 8876.4 8890.7 7404.9 7433.0 7596.3 7779.4 7831.9 7545.0 7701.7 7725.6 7792.9 7887.3 7187.3 7310.8 7321.0 7327.8 7491.5 5386.7 5433.7 5536.1 5545.5 5561.8 5418.6 5442.2 5469.7 5491.5 5521.6 09:49:10 INFO - PROCESS | 7508 | 09:49:10 INFO - PROCESS | 7508 | [#4] prototype.html Cycles:180 Average:4944.27 Median:5612.15 stddev:1444.93 (25.7%) stddev-sans-first:1407.06 09:49:10 INFO - PROCESS | 7508 | Values: 340.7 349.8 355.3 357.0 357.9 5565.6 5632.5 5643.8 5665.6 5667.0 5581.2 5587.7 5607.7 5608.7 5616.7 4271.8 4418.4 4421.5 4446.4 4453.3 4361.9 4434.5 4436.0 4450.6 4452.0 4383.6 4402.3 4407.7 4428.1 4434.6 4429.3 4441.6 4445.6 4450.1 4454.9 3854.1 3893.4 3909.5 3923.9 3927.1 5406.9 5412.7 5454.5 5476.7 5501.2 5001.0 5002.8 5005.7 5010.7 5023.2 5677.2 5877.3 5879.1 5884.4 5886.9 4263.4 4277.4 4324.3 4327.6 4337.1 5961.3 6131.3 6182.4 6223.0 6243.6 4264.4 4288.2 4303.0 4305.8 4320.6 4297.9 4313.3 4324.5 4357.0 4358.6 4864.2 4968.7 5021.9 5024.2 5027.9 5855.4 5899.9 5916.0 5918.8 5918.9 1449.9 1466.7 1467.0 1484.5 1486.9 973.6 1010.8 1013.0 1020.8 1030.4 5513.7 5555.1 5560.7 5565.2 5621.3 5865.8 5872.3 5872.6 5885.7 5898.4 5434.6 5529.7 5594.7 5615.6 5671.5 3057.7 3114.3 3118.6 3125.3 3130.9 5888.2 6085.7 6175.7 6184.9 6241.9 5872.4 5898.2 5921.9 5926.6 5937.6 6072.9 6123.7 6128.5 6188.3 6197.1 5630.4 5681.7 5773.7 5823.4 5860.9 5688.8 5722.3 5786.6 5788.5 5811.7 6165.2 6403.6 6406.7 6420.6 6420.8 4329.8 4339.7 4347.5 4369.9 4370.0 5968.6 6108.0 6111.4 6161.9 6216.3 5903.3 5928.2 5934.4 5941.5 5948.1 5907.1 5910.9 5923.4 5928.3 5941.4 5696.7 5822.5 5876.0 5884.6 5919.8 5877.9 5957.1 5967.4 5984.0 6021.8 5700.6 5799.3 5799.9 5821.1 5823.2 09:49:10 INFO - PROCESS | 7508 | 09:49:10 INFO - PROCESS | 7508 | [#5] yui.html Cycles:180 Average:18677.44 Median:4742.68 stddev:24781.78 (522.5%) stddev-sans-first:24814.68 09:49:10 INFO - PROCESS | 7508 | Values: 735.5 756.3 784.9 795.6 912.1 14841.7 16023.8 16174.3 16273.3 16280.2 12946.8 13000.6 13245.3 13695.4 13726.2 843.5 860.4 864.1 865.4 865.8 834.3 838.7 858.6 858.8 859.1 895.5 899.3 904.4 904.4 907.2 890.7 890.7 891.1 892.2 892.4 657.4 660.7 662.8 664.6 665.5 15261.7 15279.4 15476.8 15532.1 15634.3 13537.7 14388.9 14689.6 15042.3 15129.8 11209.6 11500.2 11664.6 11758.2 11762.7 3576.2 3612.3 3749.6 3798.6 3834.7 63196.1 65260.3 66001.0 66106.3 67653.3 11095.1 11124.6 11225.9 11280.7 11461.8 20212.8 20267.0 20583.0 20820.9 20833.3 8046.2 8223.6 8266.8 8268.1 8427.7 4505.1 4664.4 4698.3 4742.9 4844.8 3604.7 3773.1 3776.1 3776.1 3777.7 624.8 628.6 635.4 640.9 658.5 747.1 764.5 785.2 797.6 809.1 9661.7 9669.7 9764.4 9792.9 9946.0 649.6 720.8 755.8 763.3 764.2 4388.1 4715.7 4742.5 4950.4 4991.8 86047.0 86119.0 87860.0 90942.5 92475.0 82804.0 82971.6 83609.0 83680.3 86114.0 74371.3 74634.0 75127.0 75255.6 75313.6 9934.6 10173.1 10248.1 10276.7 10359.3 47322.8 47639.0 47938.8 48045.5 49694.0 63448.4 64217.0 65545.7 66312.0 68256.3 12477.8 12985.2 13041.3 13056.4 13557.0 14427.6 14431.6 14591.0 14637.9 14781.9 12963.6 12968.6 12996.9 13341.6 13904.3 13771.5 14053.7 14168.4 14444.6 14535.6 12610.3 12804.2 12902.4 13222.1 13511.3 10272.7 10817.5 10984.8 10986.7 11087.2 11553.5 11879.6 11890.5 12000.9 12198.5 09:49:10 INFO - PROCESS | 7508 | -------- Summary: end -------- 09:49:10 INFO - PROCESS | 7508 | 09:49:10 INFO - TEST-INFO | 7508: exit 0 09:49:11 INFO - TEST-OK | dromaeo_css | took 1112942ms 09:49:11 INFO - TEST-START | kraken 09:49:11 INFO - operating with platform_type : linux_ 09:49:11 INFO - Initialising browser for kraken test... 09:49:11 INFO - TEST-INFO | started process 7881 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyuR2Dr/profile http://localhost:55771/getInfo.html) 09:49:15 INFO - PROCESS | 7881 | __metrics Screen width/height:1600/1200 09:49:15 INFO - PROCESS | 7881 | colorDepth:24 09:49:15 INFO - PROCESS | 7881 | Browser inner width/height: 1024/697 09:49:15 INFO - PROCESS | 7881 | __metrics 09:49:15 ERROR - PROCESS | 7881 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 09:49:16 INFO - TEST-INFO | 7881: exit 0 09:49:16 INFO - Browser initialized. 09:49:16 INFO - Running cycle 1/1 for kraken test... 09:49:16 INFO - TEST-INFO | started process 8012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyuR2Dr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:28 INFO - PROCESS | 8012 | RSS: Main: 151887872 09:49:28 INFO - PROCESS | 8012 | 09:49:31 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:55771/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55771/tests/kraken/driver.html?testName=audio-beat-detection) 09:49:32 INFO - PROCESS | 8012 | RSS: Main: 156864512 09:49:32 INFO - PROCESS | 8012 | 09:49:34 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:55771/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55771/tests/kraken/driver.html?testName=audio-dft) 09:49:35 INFO - PROCESS | 8012 | RSS: Main: 155058176 09:49:35 INFO - PROCESS | 8012 | 09:49:38 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:55771/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55771/tests/kraken/driver.html?testName=audio-fft) 09:49:38 INFO - PROCESS | 8012 | RSS: Main: 155414528 09:49:38 INFO - PROCESS | 8012 | 09:49:40 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:55771/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55771/tests/kraken/driver.html?testName=audio-oscillator) 09:49:41 INFO - PROCESS | 8012 | RSS: Main: 154980352 09:49:41 INFO - PROCESS | 8012 | 09:49:43 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:55771/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55771/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:49:44 INFO - PROCESS | 8012 | RSS: Main: 155004928 09:49:44 INFO - PROCESS | 8012 | 09:49:47 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:55771/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55771/tests/kraken/driver.html?testName=imaging-darkroom) 09:49:47 INFO - PROCESS | 8012 | RSS: Main: 157392896 09:49:47 INFO - PROCESS | 8012 | 09:49:51 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:55771/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55771/tests/kraken/driver.html?testName=imaging-desaturate) 09:49:51 INFO - PROCESS | 8012 | RSS: Main: 157949952 09:49:51 INFO - PROCESS | 8012 | 09:49:54 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:55771/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55771/tests/kraken/driver.html?testName=json-parse-financial) 09:49:55 INFO - PROCESS | 8012 | RSS: Main: 158310400 09:49:55 INFO - PROCESS | 8012 | 09:49:56 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:55771/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55771/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:49:57 INFO - PROCESS | 8012 | RSS: Main: 158232576 09:49:57 INFO - PROCESS | 8012 | 09:49:59 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:55771/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55771/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:49:59 INFO - PROCESS | 8012 | RSS: Main: 157519872 09:49:59 INFO - PROCESS | 8012 | 09:50:01 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:55771/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55771/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:50:02 INFO - PROCESS | 8012 | RSS: Main: 157900800 09:50:02 INFO - PROCESS | 8012 | 09:50:04 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:55771/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55771/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:50:05 INFO - PROCESS | 8012 | RSS: Main: 157720576 09:50:05 INFO - PROCESS | 8012 | 09:50:08 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:55771/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55771/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:50:09 INFO - PROCESS | 8012 | RSS: Main: 157921280 09:50:09 INFO - PROCESS | 8012 | 09:50:10 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:55771/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55771/tests/kraken/driver.html?testName=ai-astar) 09:50:10 INFO - PROCESS | 8012 | RSS: Main: 159539200 09:50:10 INFO - PROCESS | 8012 | 09:50:10 INFO - PROCESS | 8012 | __start_tp_report 09:50:10 INFO - PROCESS | 8012 | _x_x_mozilla_page_load 09:50:10 INFO - PROCESS | 8012 | _x_x_mozilla_page_load_details 09:50:10 INFO - PROCESS | 8012 | |i|pagename|runs| 09:50:10 INFO - PROCESS | 8012 | |0;ai-astar;103;114;112;113;113;113;113;112;112;113 09:50:10 INFO - PROCESS | 8012 | |1;audio-beat-detection;144;120;120;159;120;120;119;118;144;119 09:50:10 INFO - PROCESS | 8012 | |2;audio-dft;165;162;163;164;160;163;162;162;162;161 09:50:10 INFO - PROCESS | 8012 | |3;audio-fft;77;78;76;108;75;76;77;78;97;76 09:50:10 INFO - PROCESS | 8012 | |4;audio-oscillator;83;82;118;82;82;82;94;83;81;105 09:50:10 INFO - PROCESS | 8012 | |5;imaging-gaussian-blur;118;118;117;118;119;117;118;119;117;117 09:50:10 INFO - PROCESS | 8012 | |6;imaging-darkroom;148;147;150;149;148;147;150;148;147;146 09:50:10 INFO - PROCESS | 8012 | |7;imaging-desaturate;85;85;85;85;87;85;85;85;85;85 09:50:10 INFO - PROCESS | 8012 | |8;json-parse-financial;56;53;54;53;56;53;57;53;53;52 09:50:10 INFO - PROCESS | 8012 | |9;json-stringify-tinderbox;59;60;60;62;60;61;59;58;60;60 09:50:10 INFO - PROCESS | 8012 | |10;stanford-crypto-aes;76;76;75;75;75;76;75;77;76;74 09:50:10 INFO - PROCESS | 8012 | |11;stanford-crypto-ccm;124;138;131;121;129;121;123;130;169;130 09:50:10 INFO - PROCESS | 8012 | |12;stanford-crypto-pbkdf2;157;158;154;155;153;156;157;156;154;159 09:50:10 INFO - PROCESS | 8012 | |13;stanford-crypto-sha256-iterative;64;63;63;63;64;63;64;63;63;66 09:50:10 INFO - PROCESS | 8012 | __end_tp_report 09:50:10 INFO - PROCESS | 8012 | __start_cc_report 09:50:10 INFO - PROCESS | 8012 | _x_x_mozilla_cycle_collect,810 09:50:10 INFO - PROCESS | 8012 | __end_cc_report 09:50:10 INFO - PROCESS | 8012 | __startTimestamp1483465810949__endTimestamp 09:50:10 INFO - PROCESS | 8012 | 09:50:10 INFO - PROCESS | 8012 | ------- Summary: start ------- 09:50:10 INFO - PROCESS | 8012 | Number of tests: 14 09:50:10 INFO - PROCESS | 8012 | 09:50:10 INFO - PROCESS | 8012 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:3.16 (2.8%) stddev-sans-first:0.67 09:50:10 INFO - PROCESS | 8012 | Values: 103.0 114.0 112.0 113.0 113.0 113.0 113.0 112.0 112.0 113.0 09:50:10 INFO - PROCESS | 8012 | 09:50:10 INFO - PROCESS | 8012 | [#1] audio-beat-detection Cycles:10 Average:128.30 Median:120.00 stddev:14.87 (12.4%) stddev-sans-first:14.65 09:50:10 INFO - PROCESS | 8012 | Values: 144.0 120.0 120.0 159.0 120.0 120.0 119.0 118.0 144.0 119.0 09:50:10 INFO - PROCESS | 8012 | 09:50:10 INFO - PROCESS | 8012 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:1.43 (0.9%) stddev-sans-first:1.17 09:50:10 INFO - PROCESS | 8012 | Values: 165.0 162.0 163.0 164.0 160.0 163.0 162.0 162.0 162.0 161.0 09:50:10 INFO - PROCESS | 8012 | 09:50:10 INFO - PROCESS | 8012 | [#3] audio-fft Cycles:10 Average:81.80 Median:77.00 stddev:11.25 (14.6%) stddev-sans-first:11.80 09:50:10 INFO - PROCESS | 8012 | Values: 77.0 78.0 76.0 108.0 75.0 76.0 77.0 78.0 97.0 76.0 09:50:10 INFO - PROCESS | 8012 | 09:50:10 INFO - PROCESS | 8012 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:82.00 stddev:12.71 (15.5%) stddev-sans-first:13.28 09:50:10 INFO - PROCESS | 8012 | Values: 83.0 82.0 118.0 82.0 82.0 82.0 94.0 83.0 81.0 105.0 09:50:10 INFO - PROCESS | 8012 | 09:50:10 INFO - PROCESS | 8012 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 09:50:10 INFO - PROCESS | 8012 | Values: 118.0 118.0 117.0 118.0 119.0 117.0 118.0 119.0 117.0 117.0 09:50:10 INFO - PROCESS | 8012 | 09:50:10 INFO - PROCESS | 8012 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.33 (0.9%) stddev-sans-first:1.41 09:50:10 INFO - PROCESS | 8012 | Values: 148.0 147.0 150.0 149.0 148.0 147.0 150.0 148.0 147.0 146.0 09:50:10 INFO - PROCESS | 8012 | 09:50:10 INFO - PROCESS | 8012 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 09:50:10 INFO - PROCESS | 8012 | Values: 85.0 85.0 85.0 85.0 87.0 85.0 85.0 85.0 85.0 85.0 09:50:10 INFO - PROCESS | 8012 | 09:50:10 INFO - PROCESS | 8012 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:53.50 stddev:1.70 (3.2%) stddev-sans-first:1.64 09:50:10 INFO - PROCESS | 8012 | Values: 56.0 53.0 54.0 53.0 56.0 53.0 57.0 53.0 53.0 52.0 09:50:10 INFO - PROCESS | 8012 | 09:50:10 INFO - PROCESS | 8012 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:1.10 (1.8%) stddev-sans-first:1.12 09:50:10 INFO - PROCESS | 8012 | Values: 59.0 60.0 60.0 62.0 60.0 61.0 59.0 58.0 60.0 60.0 09:50:10 INFO - PROCESS | 8012 | 09:50:10 INFO - PROCESS | 8012 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:76.00 stddev:0.85 (1.1%) stddev-sans-first:0.88 09:50:10 INFO - PROCESS | 8012 | Values: 76.0 76.0 75.0 75.0 75.0 76.0 75.0 77.0 76.0 74.0 09:50:10 INFO - PROCESS | 8012 | 09:50:10 INFO - PROCESS | 8012 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:130.00 stddev:14.18 (10.9%) stddev-sans-first:14.77 09:50:10 INFO - PROCESS | 8012 | Values: 124.0 138.0 131.0 121.0 129.0 121.0 123.0 130.0 169.0 130.0 09:50:10 INFO - PROCESS | 8012 | 09:50:10 INFO - PROCESS | 8012 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.90 Median:156.50 stddev:1.91 (1.2%) stddev-sans-first:1.99 09:50:10 INFO - PROCESS | 8012 | Values: 157.0 158.0 154.0 155.0 153.0 156.0 157.0 156.0 154.0 159.0 09:50:10 INFO - PROCESS | 8012 | 09:50:10 INFO - PROCESS | 8012 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.50 stddev:0.97 (1.5%) stddev-sans-first:1.01 09:50:10 INFO - PROCESS | 8012 | Values: 64.0 63.0 63.0 63.0 64.0 63.0 64.0 63.0 63.0 66.0 09:50:10 INFO - PROCESS | 8012 | -------- Summary: end -------- 09:50:10 INFO - PROCESS | 8012 | 09:50:11 INFO - TEST-INFO | 8012: exit 0 09:50:12 INFO - TEST-OK | kraken | took 61002ms 09:50:12 INFO - SUITE-END | took 1173s 09:50:12 INFO - Completed test suite (00:19:34) 09:50:12 INFO - javascript benchmark 09:50:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7443.564207757974, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3246.4318744219763, 3275.967240327596, 3286.0, 3295.7857739246947, 3298.290867463495, 5522.088855338864, 5567.916481252784, 5583.190437386582, 5620.943790562098, 5621.915671264935, 5627.577931655122, 5691.08942569189, 5698.316202055748, 5724.656520608766, 5785.305763308398, 5136.409312929014, 5179.870503237412, 5202.193659982709, 5209.791608335662, 5215.739213039352, 5239.5546378557865, 5249.396319423277, 5258.842234732964, 5259.289995850569, 5266.052110620087, 5010.799568017275, 5023.874403139914, 5226.216067589854, 5231.2153177023565, 5246.973765131169, 5091.338126043609, 5095.8980820383385, 5101.438841727407, 5126.71803050832, 5146.6911985281, 5105.5149760772665, 5112.923306150411, 5137.17805151174, 5184.092783762826, 5255.1329030709885, 5446.7276636168035, 5658.8019419320535, 5688.061469857468, 5736.8852622947725, 5739.311282646109, 5871.9412805871825, 5948.881022379572, 5964.582479226456, 5967.224260846106, 5968.582199246054, 5988.880222395528, 6032.215811944463, 6038.124471951586, 6039.335673075958, 6058.606190597597, 5443.510084092451, 5560.4161563036105, 5612.494875461187, 5623.184638227434, 5632.408597097327, 6077.088436734525, 6082.665453400105, 6084.847878802977, 6093.573449858467, 6102.877942441126, 5827.0, 5828.038373668297, 5862.091375836752, 5867.031939729982, 5892.057270836645, 5848.385919478478, 5873.970630146822, 5892.911606325909, 5897.498712609477, 5975.52195824333, 5865.824025279163, 5874.353821079678, 5889.411058894077, 5894.440028197314, 5895.852603684943, 5772.538196944234, 5852.678102704393, 5914.349421563625, 5922.141289512996, 5955.7617695292565, 4541.9545804542195, 4552.954470455253, 4555.271156614992, 4573.977130114395, 4617.238155704271, 4075.1238483726142, 4079.6124368184974, 4080.3063479208604, 4101.52832424269, 4141.64795992338, 5786.479216870502, 5802.158686990363, 5807.041838096751, 5809.854753631109, 5842.853928651818, 5765.1928729977835, 5802.1296805479515, 5920.37836027211, 5948.762049518057, 5974.074018527135, 5809.564282678732, 5815.302163740378, 5819.679917604488, 5820.679862607512, 5842.357340692521, 5200.7919683213, 5212.009718153615, 5226.790928362823, 5231.555317797954, 5266.1574148136115, 6126.632402055891, 6159.722812473449, 6185.969070154711, 6191.288001879841, 6248.250209974832, 6010.188624535806, 6063.878722425615, 6073.787417440369, 6074.757009719562, 6130.049842274455, 6225.470834979077, 6265.874682506415, 6282.780102696383, 6295.055741638791, 6329.050642403492, 5777.884442311214, 5823.4467725566, 5857.941420585739, 5954.612950158225, 5965.198015597486, 5968.373320801254, 5986.551008674454, 5988.461038506555, 5997.850053748692, 6078.513718902389, 5833.9416605835095, 5862.472377486047, 5902.085176797603, 5904.3210030847, 5915.083162109708, 5626.240457538343, 5723.771049157987, 5923.437273459014, 5929.288485381781, 5943.286805583358, 5773.53811695055, 5808.76764929415, 5832.0, 5874.206982057368, 5892.410758924073, 5939.287285525765, 5951.166836642787, 5962.821115366546, 5969.194158788508, 5975.462208401264, 5548.528375088163, 5587.552995760248, 5647.181158731879, 5825.825225243249, 5841.474267315962], "value": 5542.878873279216, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.7777866632014, 616.2112496005112, 636.3159603426318, 662.4071456046835, 669.1434963247045, 43536.0, 44694.329585056206, 44779.55220447794, 47801.0, 47892.52107478924, 45961.77019114908, 46245.537544624545, 46451.0, 46458.53541464584, 46675.533244667546, 8758.167974042472, 8855.291576673852, 8875.644974201025, 8889.73330800077, 8920.375573709844, 8734.0, 8834.734957951272, 8848.0, 8895.866562001544, 8917.68788092417, 8814.86777698335, 8915.465072095663, 8915.732528024137, 8932.46405215689, 8956.059613740561, 8754.080821513713, 8822.382433229677, 8861.0, 8871.290296776275, 8945.418547794405, 8636.481811091355, 8647.827043459158, 8660.48037117775, 8684.175003374668, 8725.694600689008, 42704.57295427037, 43502.12995740068, 43697.563024369665, 44076.3388549172, 44098.11803763907, 3428.108691740141, 3482.9477557836653, 3516.472529120627, 3650.0874781304674, 4072.3077076897, 33308.33383332344, 33373.16567085818, 33614.49578256328, 33864.83067584646, 34699.13252168691, 4017.13631569214, 4086.7956602169775, 4156.709030367875, 4174.269502836992, 4189.895252618679, 341013.0, 341532.0, 342926.0, 345611.2719436412, 348526.0, 59187.0, 59327.70336148292, 59421.405785941584, 59552.404475955555, 59861.40138598646, 61918.0712289316, 61977.0, 62067.689661551405, 62219.0, 62302.37697623057, 17551.824481755273, 17794.37719679805, 17830.821691783174, 17836.643267134583, 17837.46487605374, 14231.50189743354, 14304.284785760878, 14341.713165736626, 14343.92828035874, 14361.856381436051, 16326.83673163277, 16591.0, 16658.16709164537, 16676.916615416845, 16677.583060423585, 5915.822525324247, 5982.850428739229, 5991.2510936132985, 6066.969665151646, 6194.473469755121, 1033.4367769565604, 1046.8011077895328, 1078.7464945737902, 1130.9547618095348, 1147.4893672315907, 32498.83750581232, 32851.1787205317, 33032.0, 33044.66955330464, 33955.83022084874, 1170.2334970594275, 1171.5782318365382, 1176.5470293936726, 1204.6988252936767, 1228.0666693313146, 17141.657166856592, 17372.565685857702, 17437.47687569375, 17512.64974700524, 17622.207000685, 484246.0, 484664.0, 486277.0, 488243.0, 489732.0, 60226.397736022955, 60408.395916040274, 60458.39541604616, 60741.39258607446, 60755.0, 1384.6815232496583, 1404.5294826233326, 1438.3024233247077, 1438.7626041703002, 1444.0469290268372, 31386.843065784524, 32907.50638740469, 33138.33723325568, 33615.495767563996, 34028.65971340255, 53181.0, 53445.46554534405, 53617.46382536281, 53769.0, 53949.0, 422959.0, 423018.0, 423734.0, 424303.0, 425521.0, 42546.0, 42914.35628465513, 43052.78473607612, 43220.78389608032, 43303.35044974265, 47908.5209147918, 48548.27177592268, 48562.514374857215, 50013.249801252285, 50564.74717626388, 41323.380149298384, 41897.37153942632, 42079.0, 42835.14329713326, 44059.33910991273, 41483.0, 41847.79076104722, 42729.35905961351, 43796.56203437925, 43870.0, 41454.585454145075, 41804.3729344054, 42747.35878961756, 43162.1367572653, 43174.0, 36742.26515469622, 38233.80883095567, 38576.42135368028, 39087.6091239084, 39213.60786392214, 28970.42059158847, 29152.396618185354, 29391.26521836971, 29470.263243419085, 29489.0], "value": 20656.446868578758, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.9625633692971, 416.33802254415474, 419.55317586770093, 422.8942764308922, 439.8130794412374, 18124.90937545312, 19438.31965881196, 19729.605407891835, 19875.304364347252, 19916.800831991713, 18995.81004189958, 19043.904780476078, 19650.0, 19665.0, 19779.30772422962, 5524.696141712194, 5837.474627283544, 5896.852578685524, 5898.587098903078, 5901.20333754944, 5656.91514627281, 5830.970845145768, 5843.883122337551, 5876.647401155923, 5884.558658100638, 5892.734826932777, 6007.429294217064, 6022.8795424091495, 6023.518118550505, 6034.939650603482, 5453.318335208099, 5503.3395992480755, 5685.8578535536735, 5991.071383935497, 6036.5170786336985, 5303.787848486056, 5349.117395629716, 5353.411124776271, 5363.973180134074, 5374.140137578008, 14841.0, 22135.225267115573, 22648.43378915524, 22970.54058918829, 23827.166049188196, 2331.75516570761, 2342.7422983471806, 2423.4547226873988, 2461.8030557555353, 2961.4077184563175, 10409.583616655325, 10794.298370605886, 11038.227324087316, 11294.152938529644, 11427.257228280136, 1839.6596629623562, 1894.943151705451, 1897.601503684228, 1925.7592800899888, 1957.559549101455, 84452.57773711154, 89371.55314223452, 90050.5497472515, 91114.0, 92796.0, 11375.943120284346, 11505.252158609663, 11771.823422648667, 11832.70418239551, 11905.345206013579, 16902.070386128635, 16969.0, 16988.06565638902, 17046.403375881786, 17082.572935676708, 8581.828363432696, 8623.094575069654, 8657.567121644019, 8738.91261087381, 8770.868436973451, 8223.05434874997, 8269.586520673942, 8445.282151017109, 8453.704120355758, 8453.788655283666, 4915.975420122876, 5024.748762561857, 5037.546620804145, 5076.670016448919, 5165.586753059746, 2021.181421524285, 2128.9893550532456, 2148.742150941897, 2161.1679503391306, 2211.2150186683816, 934.2946075712794, 960.3661583355092, 1028.377831412, 1036.9688909332733, 1049.0, 19483.85420829661, 19710.70433943492, 19911.303104391565, 20008.59982800336, 20008.69986950197, 979.6522234606755, 991.9752006199902, 993.438707130469, 1014.5485259059648, 1045.6967479431032, 11049.723756906142, 11105.611303604335, 11222.887771122347, 11235.775284494264, 11252.212345135926, 472060.0, 473092.0, 473852.0, 478727.0, 486065.0, 57055.0, 57343.71328143332, 59065.0, 99766.0, 100931.0, 1003.418017549834, 1044.1751016696724, 1060.5492665617082, 1069.2034434346306, 1071.2929466552039, 17802.198901049742, 18203.45389638313, 18394.81605183931, 18413.26346946107, 18452.354167604608, 44560.33159502675, 45345.0, 45475.54524454713, 45602.31596526121, 46309.0, 64413.71172576428, 65030.674846625465, 65474.345256546825, 65666.34333656602, 67022.3297767016, 8770.517621530877, 8997.64009439615, 9141.954290228772, 9151.771205719644, 9191.0, 10531.684049478528, 13308.86691133115, 13369.331533423096, 13673.86326136726, 13971.30143492801, 11460.541578336773, 11550.133739969368, 11759.118541033393, 11935.045196384443, 12002.819957700816, 11833.349165795964, 12015.45930433115, 12102.273863568214, 12181.87818121843, 12184.390780460764, 12277.938610306892, 12366.876331236932, 12477.001839852972, 12754.234745915275, 12817.423215955117, 7690.692372305045, 8879.644814207617, 9048.457092574467, 9112.726618201465, 9130.086991300817, 11158.274712143684, 12216.938915305367, 12304.354563768833, 12312.692182695504, 12450.501979920702], "value": 9495.606853095827, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1487.3455679501021, 1494.970100597988, 1637.4678229575384, 1771.927983569941, 1772.9822701772978, 7716.112647045591, 7933.0876949150725, 8065.233802788733, 8680.869786953193, 8710.172533609304, 8561.61472733727, 8835.337349698782, 8838.46969181848, 9068.41055331403, 9099.818003639923, 2409.602415601428, 2440.7437219092008, 2444.4133407982135, 2450.705915290159, 2457.4716435966266, 2448.4054378405986, 2551.5279673260507, 2561.602951542505, 2570.473053024135, 2575.214559559334, 2491.9750802491926, 2498.038255271724, 2521.155412936668, 2524.3184340228217, 2526.936826579341, 2446.376174075608, 2466.124525793344, 2471.209213051824, 2482.354587807165, 2490.1657944588583, 2432.0636554926305, 2439.6706444630104, 2451.252368027751, 2454.104251948026, 2486.5151295497385, 8985.966613839426, 9006.86489702655, 9014.098590140933, 9050.77373065672, 9065.184133427958, 5498.532624726903, 5523.28197334344, 5576.832695019156, 5625.240592520039, 5649.265595472603, 3493.0917961330238, 3493.1616412061176, 3518.0677120563073, 3539.150603855082, 3594.4608308753636, 1128.458339996798, 1144.0790163918043, 1146.6789298996293, 1155.8497395338636, 1175.1891195075457, 12294.877051229463, 12335.198212116184, 12440.19138755978, 12450.813237801349, 12480.313582752944, 4605.562471565196, 4650.906981860344, 4730.337752714623, 4843.2735089736825, 4956.677815941952, 9587.664431744995, 9739.805203895883, 9771.902280977241, 9798.951005245071, 9803.264755143393, 5292.364916210003, 5305.840824775263, 5575.275214222206, 5734.197212390269, 5736.483716465538, 4537.909241815145, 4766.475687674353, 5121.385433747974, 5162.6128040397125, 5232.3459567554055, 4104.302268614343, 4112.663110702576, 4179.91640167195, 4218.704690671685, 4234.830606775756, 1361.4282001559368, 1384.3631929312628, 1388.5348408283137, 1392.262101086426, 1394.5816255123423, 918.3663272342196, 980.3774603127066, 990.0050449298553, 1017.5777052523268, 1029.341221618165, 5912.260967379078, 6205.844853878689, 6236.594621349688, 6240.656763878031, 6291.4023167799905, 460.7350773305363, 462.26269100784197, 470.3931927813151, 510.99233511497357, 511.1872123323933, 4174.248635245685, 4188.81150348235, 4301.483821941387, 4353.34699795027, 4354.869353919387, 9983.600655973825, 10272.33229840058, 10284.948575257076, 10336.0, 10340.948295258626, 10234.846477302846, 10237.078662920372, 10285.7428564285, 10316.27786054969, 10319.948400258101, 7907.762767116996, 8142.307903828241, 8420.031696354876, 8470.618822153017, 8597.742067738103, 5893.6463812171405, 6023.909641355295, 6036.426539478743, 6097.298810636834, 6118.174046503665, 10262.332948358333, 10354.223433242687, 10406.375617462976, 10466.63366782159, 10497.685069447929, 10307.330023548446, 10351.223658225512, 10364.585416583252, 10517.316374435637, 10538.156947444033, 7697.345725613161, 7917.049954005326, 7969.362451004022, 7989.400794940519, 8066.798330041796, 8595.87106193395, 8766.123387661182, 8859.202671759573, 8876.378653494452, 8890.73327800167, 7404.925950740424, 7432.962835185789, 7596.278353556403, 7779.37764978789, 7831.8825217622925, 7545.0, 7701.6534255957495, 7725.575093369918, 7792.883106753517, 7887.290143887078, 7187.281271872771, 7310.817229569303, 7321.0, 7327.816804579928, 7491.513051651626, 5386.676799392049, 5433.673979561239, 5536.058869992031, 5545.473180047889, 5561.833145005657, 5418.647787893774, 5442.238086667949, 5469.72651367438, 5491.505764481056, 5521.613487055867], "value": 4681.862217028578, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.68997212536595, 349.8215909885958, 355.31933952405126, 356.9964300356999, 357.9319929213448, 5565.609517310944, 5632.5212356949605, 5643.774249030044, 5665.603407761459, 5667.0, 5581.2186293918885, 5587.7485513151905, 5607.719614019303, 5608.663480191191, 5616.691081990499, 4271.786410679453, 4418.381426600278, 4421.535738747433, 4446.444194475691, 4453.3097369907555, 4361.912761744763, 4434.534373890743, 4436.0, 4450.57719516647, 4451.955480445203, 4383.561643835606, 4402.2516172250635, 4407.713498622596, 4428.114377124572, 4434.578715022068, 4429.291313389858, 4441.556494139385, 4445.644348452132, 4450.132224216279, 4454.933176002362, 3854.1135538825947, 3893.435451859493, 3909.491766070421, 3923.862664806718, 3927.1360300734077, 5406.864828379283, 5412.675239485604, 5454.481824226692, 5476.726163691839, 5501.202325662796, 5000.999600159928, 5002.849914502571, 5005.6996580205305, 5010.72441015744, 5023.196288593807, 5677.205191273225, 5877.324107727623, 5879.1475236090955, 5884.352721200665, 5886.911696324559, 4263.360495925605, 4277.358396240589, 4324.329728892027, 4327.567243275679, 4337.067530480962, 5961.314448838352, 6131.294901086388, 6182.350853160398, 6223.0, 6243.56295059346, 4264.445622069174, 4288.2281189385585, 4302.956970430256, 4305.83742389553, 4320.567943205717, 4297.9255186203445, 4313.309870420718, 4324.545922678137, 4356.956430435655, 4358.607725304738, 4864.246041863516, 4968.726720030433, 5021.924671129936, 5024.221245706921, 5027.949720502821, 5855.394349514425, 5899.941000589939, 5915.970420147958, 5918.822435326947, 5918.852028699231, 1449.9492517761828, 1466.7359875222348, 1466.9853301466849, 1484.5101116631702, 1486.8661820435996, 973.6154219083422, 1010.7618167744602, 1012.9949350253202, 1020.806046851096, 1030.3611760708409, 5513.696746678891, 5555.111182210827, 5560.666360018412, 5565.193047008162, 5621.297337832771, 5865.765369385262, 5872.265966754156, 5872.618279811884, 5885.733417953077, 5898.4101589840675, 5434.592405569598, 5529.723513824292, 5594.748236329375, 5615.634983726045, 5671.461211184931, 3057.7095175958248, 3114.299282661383, 3118.610173728284, 3125.3436778276364, 3130.8591113399953, 5888.234529511136, 6085.665288409092, 6175.722092505848, 6184.907226391608, 6241.906371404432, 5872.412758724094, 5898.168878938133, 5921.881562368729, 5926.585139040312, 5937.584369094122, 6072.878542429126, 6123.724432400552, 6128.540359472968, 6188.2883468400805, 6197.070439434031, 5630.4369563043365, 5681.65910045382, 5773.6824474654295, 5823.4467725566, 5860.912086318624, 5688.752942587572, 5722.284714410699, 5786.594938354275, 5788.479036886532, 5811.651300921789, 6165.229346331708, 6403.551751377358, 6406.679666016587, 6420.646864422315, 6420.775272865428, 4329.809302441728, 4339.652827773833, 4347.500037495602, 4369.868903932887, 4369.956300436955, 5968.552358573038, 6107.970071244661, 6111.449969502766, 6161.888246435521, 6216.347283535164, 5903.321118071305, 5928.199693041384, 5934.376890426443, 5941.494972927349, 5948.078047902582, 5907.143464197753, 5910.940890591211, 5923.4076592340425, 5928.34788173292, 5941.37615550361, 5696.686682232517, 5822.475977162076, 5875.970620146872, 5884.617499862496, 5919.763209471573, 5877.882442351214, 5957.106434034929, 5967.403259673998, 5983.952808258625, 6021.849453763516, 5700.572457065654, 5799.317433429718, 5799.884002320015, 5821.079043915583, 5823.242978412779], "value": 4482.332189579861, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.5476382025056, 756.2626439221759, 784.901887264092, 795.5902710104295, 912.0879120879118, 14841.703165936675, 16023.839761602381, 16174.2721577529, 16273.267702953366, 16280.185990700476, 12946.805797913039, 13000.609981700563, 13245.271510066943, 13695.383707733152, 13726.176429414241, 843.4854738609458, 860.4450129666361, 864.0970186155482, 865.3596338709341, 865.8311629232302, 834.3492076180559, 838.714836955435, 858.6222062292602, 858.7767180533075, 859.072202021815, 895.4985208283382, 899.2626046641757, 904.3759805734055, 904.430208968349, 907.1608761895253, 890.6526454682679, 890.679355432044, 891.131147131548, 892.2371372476537, 892.3887137310962, 657.4149007383432, 660.7125900233414, 662.7912207654573, 664.6178447392721, 665.527475492401, 15261.694766104727, 15279.388824447009, 15476.845231547653, 15532.145731984849, 15634.296456659364, 13537.661558461019, 14388.92805535976, 14689.632759180999, 15042.32309546073, 15129.848701513065, 11209.551617935273, 11500.194986350958, 11664.591739289084, 11758.17692761507, 11762.705932351673, 3576.2489877125836, 3612.277544491112, 3749.643783840531, 3798.601146879593, 3834.65488106069, 63196.052059219146, 65260.34739652638, 66001.0, 66106.3389366105, 67653.3234667652, 11095.1123910087, 11124.55501779936, 11225.94387028076, 11280.717982050515, 11461.770764584662, 20212.797872021387, 20267.0, 20583.0, 20820.895895520425, 20833.270835520987, 8046.235607617267, 8223.629936652866, 8266.8346633067, 8268.131846156188, 8427.662893484192, 4505.121501307213, 4664.416947881515, 4698.342232087511, 4742.905141897143, 4844.8304309349705, 3604.747667663238, 3773.0755964788805, 3776.074861658856, 3776.131489757371, 3777.697784177259, 624.7938180400457, 628.5505863307757, 635.383677832511, 640.8718256348656, 658.4732214228694, 747.1072068877747, 764.5183534373309, 785.1951749456738, 797.5613412623034, 809.1382677448498, 9661.71014869541, 9669.661561845302, 9764.365316254421, 9792.902070979342, 9946.0, 649.6004956951441, 720.8089856188114, 755.7543798265476, 763.3435245688703, 764.170874601053, 4388.144311859157, 4715.669903106818, 4742.454617719007, 4950.426402274143, 4991.785227391921, 86047.0, 86119.0, 87860.0, 90942.54528727314, 92475.0, 82804.0, 82971.5851420739, 83609.0, 83680.27142999774, 86114.0, 74371.25628743644, 74634.0, 75127.0, 75255.62372188213, 75313.6234318814, 9934.552945117632, 10173.135283500986, 10248.128909042814, 10276.743081422725, 10359.32664376813, 47322.76338618285, 47639.0, 47938.760306198245, 48045.5195448055, 49694.0, 63448.36551634609, 64217.0, 65545.67227163834, 66312.0, 68256.31743682499, 12477.812832807334, 12985.220886746825, 13041.282729449971, 13056.412461439448, 13556.983226258268, 14427.639309017359, 14431.639209019859, 14591.0, 14637.92681036588, 14781.852181478047, 12963.611091667264, 12968.610941671765, 12996.935015324863, 13341.599752007067, 13904.304784760923, 13771.517996870462, 14053.718925621635, 14168.362423690753, 14444.638884027983, 14535.563933082025, 12610.306433145897, 12804.231746095264, 12902.419391127234, 13222.074454788073, 13511.256880871253, 10272.691819245434, 10817.45912704346, 10984.835227471754, 10986.670399888017, 11087.168462365193, 11553.480093395985, 11879.643610691694, 11890.464929078385, 12000.879991199976, 12198.512059517874], "value": 7454.290053491474, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1465.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 112.0, 113.0, 113.0, 113.0, 113.0, 112.0, 112.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 120.0, 120.0, 159.0, 120.0, 120.0, 119.0, 118.0, 144.0, 119.0], "value": 128.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 163.0, 164.0, 160.0, 163.0, 162.0, 162.0, 162.0, 161.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 108.0, 75.0, 76.0, 77.0, 78.0, 97.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 118.0, 82.0, 82.0, 82.0, 94.0, 83.0, 81.0, 105.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 119.0, 117.0, 118.0, 119.0, 117.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 150.0, 149.0, 148.0, 147.0, 150.0, 148.0, 147.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, 87.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 53.0, 56.0, 53.0, 57.0, 53.0, 53.0, 52.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 62.0, 60.0, 61.0, 59.0, 58.0, 60.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 75.0, 75.0, 76.0, 75.0, 77.0, 76.0, 74.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 138.0, 131.0, 121.0, 129.0, 121.0, 123.0, 130.0, 169.0, 130.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 154.0, 155.0, 153.0, 156.0, 157.0, 156.0, 154.0, 159.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 64.0, 63.0, 64.0, 63.0, 63.0, 66.0], "value": 63.6, "unit": "score"}]}]} 09:50:12 INFO - Return code: 0 09:50:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:50:12 ERROR - # TBPL SUCCESS # 09:50:12 INFO - Running post-action listener: _resource_record_post_action 09:50:12 INFO - [mozharness: 2017-01-03 17:50:12.284345Z] Finished run-tests step (success) 09:50:12 INFO - Running post-run listener: _resource_record_post_run 09:50:12 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 266240; Write bytes: 365809664; Read time: 36; Write time: 223988 09:50:12 INFO - TinderboxPrint: CPU usage
13.3% 09:50:12 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 36 09:50:12 INFO - TinderboxPrint: I/O write bytes / time
365,809,664 / 223,988 09:50:12 INFO - TinderboxPrint: CPU idle
8,228.7 (86.7%) 09:50:12 INFO - TinderboxPrint: CPU user
1,207.7 (12.7%) 09:50:12 INFO - TinderboxPrint: Swap in / out
0 / 0 09:50:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118796288; Read time: 0; Write time: 84952 09:50:12 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 246534144; Read time: 20; Write time: 139028 09:50:12 INFO - Running post-run listener: _upload_blobber_files 09:50:12 INFO - Blob upload gear active. 09:50:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:50:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:50:12 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'] 09:50:12 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 09:50:13 INFO - (blobuploader) - INFO - Open directory for files ... 09:50:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:50:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:50:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:17 INFO - (blobuploader) - INFO - Done attempting. 09:50:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:50:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:50:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:17 INFO - (blobuploader) - INFO - Done attempting. 09:50:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:50:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:50:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:18 INFO - (blobuploader) - INFO - Done attempting. 09:50:18 INFO - (blobuploader) - INFO - Iteration through files over. 09:50:18 INFO - Return code: 0 09:50:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:50:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:50:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4abe0b49be766e2213bace872c78810b8a77d1373fa38ea55d06af6691e7a285dcf6ac4037e815e988522083ccc0a00e5f7a202e13cda846af927e6a30a9504a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c8147ed750bf922566e4af0cdee16a87d0a56032490bc11b576fe0ef079589ebffb8b89ab663fb917c6cde06ae6909f10974017b116e467d210a78a47f0d400a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c7c614445d3925c537a06725f61d6eebe72152d0706f098dbd707373a6efae9b74bb0f71ac2594e353513d9c6f9183d70f78f67a4a2bc0df3f47abdabf0517b"} 09:50:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:50:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:50:18 INFO - Contents: 09:50:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4abe0b49be766e2213bace872c78810b8a77d1373fa38ea55d06af6691e7a285dcf6ac4037e815e988522083ccc0a00e5f7a202e13cda846af927e6a30a9504a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c8147ed750bf922566e4af0cdee16a87d0a56032490bc11b576fe0ef079589ebffb8b89ab663fb917c6cde06ae6909f10974017b116e467d210a78a47f0d400a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c7c614445d3925c537a06725f61d6eebe72152d0706f098dbd707373a6efae9b74bb0f71ac2594e353513d9c6f9183d70f78f67a4a2bc0df3f47abdabf0517b"} 09:50:18 INFO - Running post-run listener: copy_logs_to_upload_dir 09:50:18 INFO - Copying logs to upload dir... 09:50:18 INFO - mkdir: /builds/slave/test/build/upload/logs 09:50:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.797077 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-03 09:50:18.642393) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 09:50:18.646654) ========= 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=0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4abe0b49be766e2213bace872c78810b8a77d1373fa38ea55d06af6691e7a285dcf6ac4037e815e988522083ccc0a00e5f7a202e13cda846af927e6a30a9504a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c8147ed750bf922566e4af0cdee16a87d0a56032490bc11b576fe0ef079589ebffb8b89ab663fb917c6cde06ae6909f10974017b116e467d210a78a47f0d400a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c7c614445d3925c537a06725f61d6eebe72152d0706f098dbd707373a6efae9b74bb0f71ac2594e353513d9c6f9183d70f78f67a4a2bc0df3f47abdabf0517b"} build_url:https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011953 build_url: 'https://queue.taskcluster.net/v1/task/XV0KPjWUQFyYG9DvUaXkRg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4abe0b49be766e2213bace872c78810b8a77d1373fa38ea55d06af6691e7a285dcf6ac4037e815e988522083ccc0a00e5f7a202e13cda846af927e6a30a9504a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c8147ed750bf922566e4af0cdee16a87d0a56032490bc11b576fe0ef079589ebffb8b89ab663fb917c6cde06ae6909f10974017b116e467d210a78a47f0d400a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c7c614445d3925c537a06725f61d6eebe72152d0706f098dbd707373a6efae9b74bb0f71ac2594e353513d9c6f9183d70f78f67a4a2bc0df3f47abdabf0517b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 09:50:18.673226) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 09:50:18.673564) ========= 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=0e2a256762fed810e2f0f810000001b3-1483464031.527148-1141195135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 09:50:18.760041) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 09:50:18.760779) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 09:50:18.761258) ========= ========= Total master_lag: 0.17 =========