builder: larch_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-006 starttime: 1476228692.84 results: success (0) buildid: 20161011134948 builduid: edc2734193c9474da419c174d0d59e54 revision: 22a929d86e4db43d828efe54430a34c182b2dbc2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 16:31:32.839418) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 16:31:32.840471) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 16:31:32.841198) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 16:31:32.859811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 16:31:32.860474) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-11 16:31:33-- 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% 32.5M=0s 2016-10-11 16:31:33 (32.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115385 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 16:31:32.991959) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 16:31:32.992311) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022617 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 16:31:33.045891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 16:31:33.046726) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 22a929d86e4db43d828efe54430a34c182b2dbc2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 22a929d86e4db43d828efe54430a34c182b2dbc2 --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=e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-11 16:31:33,420 truncating revision to first 12 chars 2016-10-11 16:31:33,420 Setting DEBUG logging. 2016-10-11 16:31:33,420 attempt 1/10 2016-10-11 16:31:33,420 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/22a929d86e4d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 16:31:34,345 unpacking tar archive at: larch-22a929d86e4d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.274437 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 16:31:34.340086) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 16:31:34.340449) ========= script_repo_revision: 22a929d86e4db43d828efe54430a34c182b2dbc2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 16:31:34.340954) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 16:31:34.341257) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 16:31:34.354723) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-11 16:31:34.355419) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 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', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-Non-PGO'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:31:34 INFO - MultiFileLogger online at 20161011 16:31:34 in /builds/slave/test 16:31:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 16:31:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:31:34 INFO - {'append_to_log': False, 16:31:34 INFO - 'base_work_dir': '/builds/slave/test', 16:31:34 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 16:31:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:31:34 INFO - 'branch': 'Larch-Non-PGO', 16:31:34 INFO - 'buildbot_json_path': 'buildprops.json', 16:31:34 INFO - 'config_files': ('talos/linux_config.py',), 16:31:34 INFO - 'default_actions': ('clobber', 16:31:34 INFO - 'read-buildbot-config', 16:31:34 INFO - 'download-and-extract', 16:31:34 INFO - 'populate-webroot', 16:31:34 INFO - 'create-virtualenv', 16:31:34 INFO - 'install', 16:31:34 INFO - 'run-tests'), 16:31:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:31:34 INFO - 'download_minidump_stackwalk': True, 16:31:34 INFO - 'download_symbols': 'ondemand', 16:31:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:31:34 INFO - 'tooltool.py': '/tools/tooltool.py', 16:31:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:31:34 INFO - '/tools/misc-python/virtualenv.py')}, 16:31:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:31:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:31:34 INFO - 'installer_path': 'installer.exe', 16:31:34 INFO - 'log_level': 'info', 16:31:34 INFO - 'log_name': 'talos', 16:31:34 INFO - 'log_to_console': True, 16:31:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:31:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:31:34 INFO - 'opt_config_files': (), 16:31:34 INFO - 'pip_index': False, 16:31:34 INFO - 'sps_profile': False, 16:31:34 INFO - 'sps_profile_interval': 0, 16:31:34 INFO - 'suite': 'dromaeojs-e10s', 16:31:34 INFO - 'system_bits': '32', 16:31:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:31:34 INFO - 'title': 'talos-linux64-ix-006', 16:31:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:31:34 INFO - 'use_talos_json': True, 16:31:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:31:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:31:34 INFO - 'work_dir': 'build'} 16:31:34 INFO - [mozharness: 2016-10-11 23:31:34.823623Z] Running clobber step. 16:31:34 INFO - Running pre-action listener: _resource_record_pre_action 16:31:34 INFO - Running main action method: clobber 16:31:34 INFO - rmtree: /builds/slave/test/build 16:31:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:31:35 INFO - Running post-action listener: _resource_record_post_action 16:31:35 INFO - [mozharness: 2016-10-11 23:31:35.289185Z] Finished clobber step (success) 16:31:35 INFO - [mozharness: 2016-10-11 23:31:35.289287Z] Running read-buildbot-config step. 16:31:35 INFO - Running pre-action listener: _resource_record_pre_action 16:31:35 INFO - Running main action method: read_buildbot_config 16:31:35 INFO - Using buildbot properties: 16:31:35 INFO - { 16:31:35 INFO - "project": "", 16:31:35 INFO - "product": "firefox", 16:31:35 INFO - "script_repo_revision": "production", 16:31:35 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs-e10s", 16:31:35 INFO - "repository": "", 16:31:35 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs-e10s", 16:31:35 INFO - "buildid": "20161011134948", 16:31:35 INFO - "pgo_build": "False", 16:31:35 INFO - "basedir": "/builds/slave/test", 16:31:35 INFO - "buildnumber": 3, 16:31:35 INFO - "slavename": "talos-linux64-ix-006", 16:31:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:31:35 INFO - "platform": "ubuntu64_hw", 16:31:35 INFO - "scheduler": "tests-larch-linux64-talos", 16:31:35 INFO - "branch": "larch", 16:31:35 INFO - "repo_path": "projects/larch", 16:31:35 INFO - "revision": "22a929d86e4db43d828efe54430a34c182b2dbc2", 16:31:35 INFO - "stage_platform": "linux64", 16:31:35 INFO - "builduid": "edc2734193c9474da419c174d0d59e54", 16:31:35 INFO - "slavebuilddir": "test" 16:31:35 INFO - } 16:31:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 16:31:35 INFO - Running post-action listener: _resource_record_post_action 16:31:35 INFO - [mozharness: 2016-10-11 23:31:35.291723Z] Finished read-buildbot-config step (success) 16:31:35 INFO - [mozharness: 2016-10-11 23:31:35.291822Z] Running download-and-extract step. 16:31:35 INFO - Running pre-action listener: _resource_record_pre_action 16:31:35 INFO - Running main action method: download_and_extract 16:31:35 INFO - mkdir: /builds/slave/test/build/tests 16:31:35 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')]} 16:31:35 INFO - trying https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:31:35 INFO - Downloading https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:31:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:31:35 INFO - Downloaded 1361 bytes. 16:31:35 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:31:35 INFO - Using the following test package requirements: 16:31:35 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:31:35 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:31:35 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:31:35 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:35 INFO - u'jsshell-linux-x86_64.zip'], 16:31:35 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:31:35 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:31:35 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:31:35 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:31:35 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:31:35 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:31:35 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:31:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:31:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:31:35 INFO - Fetch https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:31:36 INFO - Http code: 200 16:31:36 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 16:31:36 INFO - x-amz-cf-id: 0bdlRTwqvOiPcAuFtYoc_lzb6hAU-Oq9MrZ-wDw77yXGQzoBqQHF-A== 16:31:36 INFO - x-amz-version-id: 6xZAK8nPUgJRnaoPe2UEJiop4TUt.NEy 16:31:36 INFO - Expected file size: 20528584 16:31:36 INFO - Obtained file size: 20528584 16:31:40 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:31:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:31:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:31:40 INFO - Fetch https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:31:41 INFO - Http code: 200 16:31:41 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 16:31:41 INFO - x-amz-cf-id: _bEJqPPdu1acXSwOt6RQ0I2PcSXz1eNbK3eQzrqS2jGtEuJSRZiDnQ== 16:31:41 INFO - x-amz-version-id: 6xZAK8nPUgJRnaoPe2UEJiop4TUt.NEy 16:31:41 INFO - Expected file size: 20528584 16:31:41 INFO - Obtained file size: 20528584 16:31:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 16:31:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:31:46 INFO - Fetch https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:31:46 INFO - Http code: 200 16:31:46 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 16:31:46 INFO - x-amz-cf-id: _-72Vrg3i9xb2UtVDoKluIIoSveKrz3eiFroaVQENb_Xc_hdbxuw4Q== 16:31:46 INFO - x-amz-version-id: uB1740G02rbPJX3xYNNgHtJg5qAitFdF 16:31:46 INFO - Expected file size: 14409006 16:31:46 INFO - Obtained file size: 14409006 16:31:47 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')]} 16:31:47 INFO - trying https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:31:47 INFO - Downloading https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:31:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:31:48 INFO - Downloaded 56015236 bytes. 16:31:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:31:48 INFO - mkdir: /builds/slave/test/properties 16:31:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:31:48 INFO - Writing to file /builds/slave/test/properties/build_url 16:31:48 INFO - Contents: 16:31:48 INFO - build_url:https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:31:49 INFO - Running post-action listener: _resource_record_post_action 16:31:49 INFO - Running post-action listener: set_extra_try_arguments 16:31:49 INFO - [mozharness: 2016-10-11 23:31:49.005592Z] Finished download-and-extract step (success) 16:31:49 INFO - [mozharness: 2016-10-11 23:31:49.005820Z] Running populate-webroot step. 16:31:49 INFO - Running pre-action listener: _resource_record_pre_action 16:31:49 INFO - Running main action method: populate_webroot 16:31:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:31:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:31:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:31:49 INFO - '--tppagecycles', 16:31:49 INFO - '7'], 16:31:49 INFO - 'tests': ['tsvgm']}}, 16:31:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:31:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:31:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:31:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:31:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:31:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:31:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:49 INFO - 'talos_options': ['--disable-e10s'], 16:31:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:49 INFO - 'talos_options': ['--disable-e10s'], 16:31:49 INFO - 'tests': ['damp', 'tps']}, 16:31:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:49 INFO - 'tests': ['damp', 'tps']}, 16:31:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:31:49 INFO - 'tests': ['dromaeo_dom']}, 16:31:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:31:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:31:49 INFO - 'tests': ['basic_compositor_video']}, 16:31:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:31:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:31:49 INFO - 'tests': ['a11yr', 16:31:49 INFO - 'ts_paint', 16:31:49 INFO - 'tpaint', 16:31:49 INFO - 'sessionrestore', 16:31:49 INFO - 'sessionrestore_no_auto_restore', 16:31:49 INFO - 'tabpaint']}, 16:31:49 INFO - 'other-e10s': {'tests': ['a11yr', 16:31:49 INFO - 'ts_paint', 16:31:49 INFO - 'tpaint', 16:31:49 INFO - 'sessionrestore', 16:31:49 INFO - 'sessionrestore_no_auto_restore', 16:31:49 INFO - 'tabpaint']}, 16:31:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:31:49 INFO - 'ts_paint', 16:31:49 INFO - 'tpaint', 16:31:49 INFO - 'sessionrestore', 16:31:49 INFO - 'sessionrestore_no_auto_restore', 16:31:49 INFO - 'tabpaint']}, 16:31:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:31:49 INFO - 'ts_paint', 16:31:49 INFO - 'tpaint', 16:31:49 INFO - 'sessionrestore', 16:31:49 INFO - 'sessionrestore_no_auto_restore', 16:31:49 INFO - 'tabpaint']}, 16:31:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:31:49 INFO - 'tests': ['a11yr', 16:31:49 INFO - 'ts_paint', 16:31:49 INFO - 'tpaint', 16:31:49 INFO - 'sessionrestore', 16:31:49 INFO - 'sessionrestore_no_auto_restore', 16:31:49 INFO - 'tabpaint']}, 16:31:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:31:49 INFO - 'tests': ['a11yr', 16:31:49 INFO - 'ts_paint', 16:31:49 INFO - 'tpaint', 16:31:49 INFO - 'sessionrestore', 16:31:49 INFO - 'sessionrestore_no_auto_restore', 16:31:49 INFO - 'tabpaint']}, 16:31:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:31:49 INFO - 'tests': ['tsvgx', 16:31:49 INFO - 'tsvgr_opacity', 16:31:49 INFO - 'tart', 16:31:49 INFO - 'tscrollx', 16:31:49 INFO - 'cart']}, 16:31:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:31:49 INFO - 'tsvgr_opacity', 16:31:49 INFO - 'tart', 16:31:49 INFO - 'tscrollx', 16:31:49 INFO - 'cart']}, 16:31:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:49 INFO - 'talos_options': ['--disable-e10s'], 16:31:49 INFO - 'tests': ['tp5o']}, 16:31:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:49 INFO - 'tests': ['tp5o']}, 16:31:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:49 INFO - 'talos_options': ['--disable-e10s', 16:31:49 INFO - '--xperf_path', 16:31:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:49 INFO - 'tests': ['tp5n']}, 16:31:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:49 INFO - 'talos_options': ['--xperf_path', 16:31:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:49 INFO - 'tests': ['tp5n']}}, 16:31:49 INFO - 'talos.zip': {'path': '', 16:31:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:31:49 INFO - Running post-action listener: _resource_record_post_action 16:31:49 INFO - [mozharness: 2016-10-11 23:31:49.025533Z] Finished populate-webroot step (success) 16:31:49 INFO - [mozharness: 2016-10-11 23:31:49.025622Z] Running create-virtualenv step. 16:31:49 INFO - Running pre-action listener: _resource_record_pre_action 16:31:49 INFO - Running main action method: create_virtualenv 16:31:49 INFO - Creating virtualenv /builds/slave/test/build/venv 16:31:49 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 16:31:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:31:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:31:49 INFO - Using real prefix '/usr' 16:31:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:31:49 INFO - Installing distribute.............................................................................................................................................................................................done. 16:31:51 INFO - Installing pip.................done. 16:31:51 INFO - Return code: 0 16:31:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:31:51 INFO - Reading from file tmpfile_stdout 16:31:51 INFO - Output received: 16:31:51 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) 16:31:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a96bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', '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 16:31:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:31:51 INFO - Using env: {'DISPLAY': ':0', 16:31:51 INFO - 'HOME': '/home/cltbld', 16:31:51 INFO - 'LANG': 'en_US.UTF-8', 16:31:51 INFO - 'LANGUAGE': 'en_US:en', 16:31:51 INFO - 'LOGNAME': 'cltbld', 16:31:51 INFO - 'MAIL': '/var/mail/cltbld', 16:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:51 INFO - 'MOZ_NO_REMOTE': '1', 16:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:51 INFO - 'NO_EM_RESTART': '1', 16:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:51 INFO - 'PWD': '/builds/slave/test', 16:31:51 INFO - 'SHELL': '/bin/bash', 16:31:51 INFO - 'SHLVL': '1', 16:31:51 INFO - 'TERM': 'linux', 16:31:51 INFO - 'TMOUT': '86400', 16:31:51 INFO - 'USER': 'cltbld', 16:31:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', 16:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:51 INFO - '_': '/tools/buildbot/bin/python'} 16:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:52 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 16:31:52 INFO - Cleaning up... 16:31:52 INFO - Return code: 0 16:31:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:31:52 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')]} 16:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:52 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')]} 16:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:52 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 0x7f7a96bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', '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 16:31:52 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 16:31:52 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 16:31:52 INFO - Using env: {'DISPLAY': ':0', 16:31:52 INFO - 'HOME': '/home/cltbld', 16:31:52 INFO - 'LANG': 'en_US.UTF-8', 16:31:52 INFO - 'LANGUAGE': 'en_US:en', 16:31:52 INFO - 'LOGNAME': 'cltbld', 16:31:52 INFO - 'MAIL': '/var/mail/cltbld', 16:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:52 INFO - 'MOZ_NO_REMOTE': '1', 16:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:52 INFO - 'NO_EM_RESTART': '1', 16:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:52 INFO - 'PWD': '/builds/slave/test', 16:31:52 INFO - 'SHELL': '/bin/bash', 16:31:52 INFO - 'SHLVL': '1', 16:31:52 INFO - 'TERM': 'linux', 16:31:52 INFO - 'TMOUT': '86400', 16:31:52 INFO - 'USER': 'cltbld', 16:31:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', 16:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:52 INFO - '_': '/tools/buildbot/bin/python'} 16:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:52 INFO - Downloading/unpacking psutil>=3.1.1 16:31:52 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 16:31:52 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 16:31:52 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 16:31:52 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 16:31:52 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 16:31:52 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 16:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:31:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:54 INFO - Installing collected packages: psutil 16:31:54 INFO - Running setup.py install for psutil 16:31:54 INFO - building 'psutil._psutil_linux' extension 16:31:54 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 16:31:54 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 16:31:54 INFO - building 'psutil._psutil_posix' extension 16:31:54 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 16:31:54 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 16:31:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:54 INFO - Successfully installed psutil 16:31:54 INFO - Cleaning up... 16:31:54 INFO - Return code: 0 16:31:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:31:54 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')]} 16:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:54 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')]} 16:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:54 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 0x7f7a96bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', '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 16:31:54 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 16:31:54 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 16:31:54 INFO - Using env: {'DISPLAY': ':0', 16:31:54 INFO - 'HOME': '/home/cltbld', 16:31:54 INFO - 'LANG': 'en_US.UTF-8', 16:31:54 INFO - 'LANGUAGE': 'en_US:en', 16:31:54 INFO - 'LOGNAME': 'cltbld', 16:31:54 INFO - 'MAIL': '/var/mail/cltbld', 16:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:54 INFO - 'MOZ_NO_REMOTE': '1', 16:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:54 INFO - 'NO_EM_RESTART': '1', 16:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:54 INFO - 'PWD': '/builds/slave/test', 16:31:54 INFO - 'SHELL': '/bin/bash', 16:31:54 INFO - 'SHLVL': '1', 16:31:54 INFO - 'TERM': 'linux', 16:31:54 INFO - 'TMOUT': '86400', 16:31:54 INFO - 'USER': 'cltbld', 16:31:54 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', 16:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:54 INFO - '_': '/tools/buildbot/bin/python'} 16:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:31:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:31:57 INFO - Installing collected packages: mozsystemmonitor 16:31:57 INFO - Running setup.py install for mozsystemmonitor 16:31:57 INFO - Successfully installed mozsystemmonitor 16:31:57 INFO - Cleaning up... 16:31:57 INFO - Return code: 0 16:31:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:57 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 0x7f7a96bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', '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 16:31:57 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 16:31:57 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 16:31:57 INFO - Using env: {'DISPLAY': ':0', 16:31:57 INFO - 'HOME': '/home/cltbld', 16:31:57 INFO - 'LANG': 'en_US.UTF-8', 16:31:57 INFO - 'LANGUAGE': 'en_US:en', 16:31:57 INFO - 'LOGNAME': 'cltbld', 16:31:57 INFO - 'MAIL': '/var/mail/cltbld', 16:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:57 INFO - 'MOZ_NO_REMOTE': '1', 16:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:57 INFO - 'NO_EM_RESTART': '1', 16:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:57 INFO - 'PWD': '/builds/slave/test', 16:31:57 INFO - 'SHELL': '/bin/bash', 16:31:57 INFO - 'SHLVL': '1', 16:31:57 INFO - 'TERM': 'linux', 16:31:57 INFO - 'TMOUT': '86400', 16:31:57 INFO - 'USER': 'cltbld', 16:31:57 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', 16:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:57 INFO - '_': '/tools/buildbot/bin/python'} 16:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:57 INFO - Downloading/unpacking jsonschema==2.5.1 16:31:57 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 16:31:57 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 16:31:57 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 16:31:57 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 16:31:57 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 16:31:57 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 16:31:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:31:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:59 INFO - Downloading functools32-3.2.3-2.tar.gz 16:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:31:59 INFO - warning: no files found matching '*.txt' 16:31:59 INFO - no previously-included directories found matching 'build' 16:31:59 INFO - no previously-included directories found matching 'dist' 16:31:59 INFO - no previously-included directories found matching '.git*' 16:31:59 INFO - Installing collected packages: jsonschema, functools32 16:31:59 INFO - Running setup.py install for functools32 16:31:59 INFO - warning: no files found matching '*.txt' 16:31:59 INFO - no previously-included directories found matching 'build' 16:31:59 INFO - no previously-included directories found matching 'dist' 16:31:59 INFO - no previously-included directories found matching '.git*' 16:31:59 INFO - Successfully installed jsonschema functools32 16:31:59 INFO - Cleaning up... 16:31:59 INFO - Return code: 0 16:31:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:31:59 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')]} 16:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:59 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')]} 16:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:59 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 0x7f7a96bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', '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 16:31:59 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 16:31:59 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 16:31:59 INFO - Using env: {'DISPLAY': ':0', 16:31:59 INFO - 'HOME': '/home/cltbld', 16:31:59 INFO - 'LANG': 'en_US.UTF-8', 16:31:59 INFO - 'LANGUAGE': 'en_US:en', 16:31:59 INFO - 'LOGNAME': 'cltbld', 16:31:59 INFO - 'MAIL': '/var/mail/cltbld', 16:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:59 INFO - 'MOZ_NO_REMOTE': '1', 16:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:59 INFO - 'NO_EM_RESTART': '1', 16:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:59 INFO - 'PWD': '/builds/slave/test', 16:31:59 INFO - 'SHELL': '/bin/bash', 16:31:59 INFO - 'SHLVL': '1', 16:31:59 INFO - 'TERM': 'linux', 16:31:59 INFO - 'TMOUT': '86400', 16:31:59 INFO - 'USER': 'cltbld', 16:31:59 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', 16:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:59 INFO - '_': '/tools/buildbot/bin/python'} 16:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:32:00 INFO - Cleaning up... 16:32:00 INFO - Return code: 0 16:32:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7a96bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', '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 16:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:32:00 INFO - Using env: {'DISPLAY': ':0', 16:32:00 INFO - 'HOME': '/home/cltbld', 16:32:00 INFO - 'LANG': 'en_US.UTF-8', 16:32:00 INFO - 'LANGUAGE': 'en_US:en', 16:32:00 INFO - 'LOGNAME': 'cltbld', 16:32:00 INFO - 'MAIL': '/var/mail/cltbld', 16:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:00 INFO - 'MOZ_NO_REMOTE': '1', 16:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:00 INFO - 'NO_EM_RESTART': '1', 16:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:00 INFO - 'PWD': '/builds/slave/test', 16:32:00 INFO - 'SHELL': '/bin/bash', 16:32:00 INFO - 'SHLVL': '1', 16:32:00 INFO - 'TERM': 'linux', 16:32:00 INFO - 'TMOUT': '86400', 16:32:00 INFO - 'USER': 'cltbld', 16:32:00 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', 16:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:00 INFO - '_': '/tools/buildbot/bin/python'} 16:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:00 INFO - Downloading/unpacking blobuploader==1.2.4 16:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:02 INFO - Downloading blobuploader-1.2.4.tar.gz 16:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:32:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:32:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32:02 INFO - Downloading docopt-0.6.1.tar.gz 16:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:32:02 INFO - Installing collected packages: blobuploader, requests, docopt 16:32:02 INFO - Running setup.py install for blobuploader 16:32:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:32:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:32:03 INFO - Running setup.py install for requests 16:32:03 INFO - Running setup.py install for docopt 16:32:03 INFO - Successfully installed blobuploader requests docopt 16:32:03 INFO - Cleaning up... 16:32:03 INFO - Return code: 0 16:32:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:03 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 0x7f7a96bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', '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 16:32:03 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 16:32:03 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 16:32:03 INFO - Using env: {'DISPLAY': ':0', 16:32:03 INFO - 'HOME': '/home/cltbld', 16:32:03 INFO - 'LANG': 'en_US.UTF-8', 16:32:03 INFO - 'LANGUAGE': 'en_US:en', 16:32:03 INFO - 'LOGNAME': 'cltbld', 16:32:03 INFO - 'MAIL': '/var/mail/cltbld', 16:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:03 INFO - 'MOZ_NO_REMOTE': '1', 16:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:03 INFO - 'NO_EM_RESTART': '1', 16:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:03 INFO - 'PWD': '/builds/slave/test', 16:32:03 INFO - 'SHELL': '/bin/bash', 16:32:03 INFO - 'SHLVL': '1', 16:32:03 INFO - 'TERM': 'linux', 16:32:03 INFO - 'TMOUT': '86400', 16:32:03 INFO - 'USER': 'cltbld', 16:32:03 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', 16:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:03 INFO - '_': '/tools/buildbot/bin/python'} 16:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:03 INFO - Running setup.py (path:/tmp/pip-xp3x_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:03 INFO - Running setup.py (path:/tmp/pip-NqfDWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:03 INFO - Running setup.py (path:/tmp/pip-qTrQrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:04 INFO - Running setup.py (path:/tmp/pip-Co7mOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:04 INFO - Running setup.py (path:/tmp/pip-jBwn4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:04 INFO - Running setup.py (path:/tmp/pip-KlTFvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:04 INFO - Running setup.py (path:/tmp/pip-PphNd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:04 INFO - Running setup.py (path:/tmp/pip-4gzpRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:04 INFO - Running setup.py (path:/tmp/pip-pAVjmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:04 INFO - Running setup.py (path:/tmp/pip-NUYaaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:04 INFO - Running setup.py (path:/tmp/pip-ndywVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:04 INFO - Running setup.py (path:/tmp/pip-lk5LsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:04 INFO - Running setup.py (path:/tmp/pip-in4fFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:04 INFO - Running setup.py (path:/tmp/pip-ai9gq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:04 INFO - Running setup.py (path:/tmp/pip-IsUbuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:04 INFO - Running setup.py (path:/tmp/pip-hM_9YG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:04 INFO - Running setup.py (path:/tmp/pip-guM_BC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:32:05 INFO - Running setup.py install for manifestparser 16:32:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:32:05 INFO - Running setup.py install for mozcrash 16:32:05 INFO - Running setup.py install for mozdebug 16:32:05 INFO - Running setup.py install for mozdevice 16:32:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:32:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:32:05 INFO - Running setup.py install for mozfile 16:32:05 INFO - Running setup.py install for mozhttpd 16:32:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:32:05 INFO - Running setup.py install for mozinfo 16:32:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:32:05 INFO - Running setup.py install for mozInstall 16:32:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:32:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:32:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:32:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:32:05 INFO - Running setup.py install for mozleak 16:32:05 INFO - Running setup.py install for mozlog 16:32:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:32:06 INFO - Running setup.py install for moznetwork 16:32:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:32:06 INFO - Running setup.py install for mozprocess 16:32:06 INFO - Running setup.py install for mozprofile 16:32:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:32:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:32:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:32:06 INFO - Running setup.py install for mozrunner 16:32:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:32:06 INFO - Running setup.py install for mozscreenshot 16:32:06 INFO - Running setup.py install for moztest 16:32:06 INFO - Running setup.py install for mozversion 16:32:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:32:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:32:06 INFO - Cleaning up... 16:32:06 INFO - Return code: 0 16:32:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:06 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 0x7f7a96bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', '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 16:32:06 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 16:32:06 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 16:32:06 INFO - Using env: {'DISPLAY': ':0', 16:32:06 INFO - 'HOME': '/home/cltbld', 16:32:06 INFO - 'LANG': 'en_US.UTF-8', 16:32:06 INFO - 'LANGUAGE': 'en_US:en', 16:32:06 INFO - 'LOGNAME': 'cltbld', 16:32:06 INFO - 'MAIL': '/var/mail/cltbld', 16:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:06 INFO - 'MOZ_NO_REMOTE': '1', 16:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:06 INFO - 'NO_EM_RESTART': '1', 16:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:06 INFO - 'PWD': '/builds/slave/test', 16:32:06 INFO - 'SHELL': '/bin/bash', 16:32:06 INFO - 'SHLVL': '1', 16:32:06 INFO - 'TERM': 'linux', 16:32:06 INFO - 'TMOUT': '86400', 16:32:06 INFO - 'USER': 'cltbld', 16:32:06 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', 16:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:06 INFO - '_': '/tools/buildbot/bin/python'} 16:32:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:07 INFO - Running setup.py (path:/tmp/pip-STF2Oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:07 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)) 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:07 INFO - Running setup.py (path:/tmp/pip-6H3PUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:07 INFO - Running setup.py (path:/tmp/pip-90Ol5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:07 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)) 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:07 INFO - Running setup.py (path:/tmp/pip-AClEMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:07 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)) 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:07 INFO - Running setup.py (path:/tmp/pip-efv1jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:07 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)) 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:07 INFO - Running setup.py (path:/tmp/pip-v0alMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:07 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)) 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:07 INFO - Running setup.py (path:/tmp/pip-bUYGog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:07 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)) 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:07 INFO - Running setup.py (path:/tmp/pip-oqunMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:07 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)) 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:07 INFO - Running setup.py (path:/tmp/pip-TOtdsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:07 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)) 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:07 INFO - Running setup.py (path:/tmp/pip-Tyz6Sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:07 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)) 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:07 INFO - Running setup.py (path:/tmp/pip-6EoH3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:07 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)) 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:07 INFO - Running setup.py (path:/tmp/pip-n7iIYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:07 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)) 16:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:07 INFO - Running setup.py (path:/tmp/pip-4233I5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:08 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)) 16:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:08 INFO - Running setup.py (path:/tmp/pip-43ZuRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 16:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:08 INFO - Running setup.py (path:/tmp/pip-xLOt69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:08 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)) 16:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:08 INFO - Running setup.py (path:/tmp/pip-65azSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:08 INFO - Running setup.py (path:/tmp/pip-EAIMjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:08 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)) 16:32:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:32:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:32:08 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)) 16:32:08 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)) 16:32:08 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)) 16:32:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:10 INFO - Downloading blessings-1.6.tar.gz 16:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:32:10 INFO - Installing collected packages: blessings 16:32:10 INFO - Running setup.py install for blessings 16:32:10 INFO - Successfully installed blessings 16:32:10 INFO - Cleaning up... 16:32:10 INFO - Return code: 0 16:32:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:32:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:10 INFO - Reading from file tmpfile_stdout 16:32:10 INFO - Current package versions: 16:32:10 INFO - argparse == 1.2.1 16:32:10 INFO - blessings == 1.6 16:32:10 INFO - blobuploader == 1.2.4 16:32:10 INFO - docopt == 0.6.1 16:32:10 INFO - functools32 == 3.2.3-2 16:32:10 INFO - jsonschema == 2.5.1 16:32:10 INFO - manifestparser == 1.1 16:32:10 INFO - mozInstall == 1.12 16:32:10 INFO - mozcrash == 0.17 16:32:10 INFO - mozdebug == 0.1 16:32:10 INFO - mozdevice == 0.48 16:32:10 INFO - mozfile == 1.2 16:32:10 INFO - mozhttpd == 0.7 16:32:10 INFO - mozinfo == 0.9 16:32:10 INFO - mozleak == 0.1 16:32:10 INFO - mozlog == 3.4 16:32:10 INFO - moznetwork == 0.27 16:32:10 INFO - mozprocess == 0.23 16:32:10 INFO - mozprofile == 0.28 16:32:10 INFO - mozrunner == 6.12 16:32:10 INFO - mozscreenshot == 0.1 16:32:10 INFO - mozsystemmonitor == 0.3 16:32:10 INFO - moztest == 0.7 16:32:10 INFO - mozversion == 1.4 16:32:10 INFO - psutil == 3.1.1 16:32:10 INFO - requests == 1.2.3 16:32:10 INFO - wsgiref == 0.1.2 16:32:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32: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')]} 16:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:10 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 0x7f7a96bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', '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 16:32:10 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 16:32:10 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 16:32:10 INFO - Using env: {'DISPLAY': ':0', 16:32:10 INFO - 'HOME': '/home/cltbld', 16:32:10 INFO - 'LANG': 'en_US.UTF-8', 16:32:10 INFO - 'LANGUAGE': 'en_US:en', 16:32:10 INFO - 'LOGNAME': 'cltbld', 16:32:10 INFO - 'MAIL': '/var/mail/cltbld', 16:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:10 INFO - 'MOZ_NO_REMOTE': '1', 16:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:10 INFO - 'NO_EM_RESTART': '1', 16:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:10 INFO - 'PWD': '/builds/slave/test', 16:32:10 INFO - 'SHELL': '/bin/bash', 16:32:10 INFO - 'SHLVL': '1', 16:32:10 INFO - 'TERM': 'linux', 16:32:10 INFO - 'TMOUT': '86400', 16:32:10 INFO - 'USER': 'cltbld', 16:32:10 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', 16:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:10 INFO - '_': '/tools/buildbot/bin/python'} 16:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:10 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)) 16:32:10 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)) 16:32:10 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)) 16:32:10 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)) 16:32:10 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)) 16:32:10 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)) 16:32:10 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)) 16:32:10 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)) 16:32:10 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)) 16:32:10 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)) 16:32:10 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)) 16:32:10 INFO - Cleaning up... 16:32:10 INFO - Return code: 0 16:32:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32: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')]} 16:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a96bb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', '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 16:32: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', 'jsonschema'] in /builds/slave/test/build 16:32: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 jsonschema 16:32:10 INFO - Using env: {'DISPLAY': ':0', 16:32:10 INFO - 'HOME': '/home/cltbld', 16:32:10 INFO - 'LANG': 'en_US.UTF-8', 16:32:10 INFO - 'LANGUAGE': 'en_US:en', 16:32:10 INFO - 'LOGNAME': 'cltbld', 16:32:10 INFO - 'MAIL': '/var/mail/cltbld', 16:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:10 INFO - 'MOZ_NO_REMOTE': '1', 16:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:10 INFO - 'NO_EM_RESTART': '1', 16:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:10 INFO - 'PWD': '/builds/slave/test', 16:32:10 INFO - 'SHELL': '/bin/bash', 16:32:10 INFO - 'SHLVL': '1', 16:32:10 INFO - 'TERM': 'linux', 16:32:10 INFO - 'TMOUT': '86400', 16:32:10 INFO - 'USER': 'cltbld', 16:32:10 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', 16:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:10 INFO - '_': '/tools/buildbot/bin/python'} 16:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:32:11 INFO - Cleaning up... 16:32:11 INFO - Return code: 0 16:32:11 INFO - Running post-action listener: _resource_record_post_action 16:32:11 INFO - Running post-action listener: _start_resource_monitoring 16:32:11 INFO - Starting resource monitoring. 16:32:11 INFO - [mozharness: 2016-10-11 23:32:11.238530Z] Finished create-virtualenv step (success) 16:32:11 INFO - [mozharness: 2016-10-11 23:32:11.238988Z] Running install step. 16:32:11 INFO - Running pre-action listener: _resource_record_pre_action 16:32:11 INFO - Running main action method: install 16:32:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:11 INFO - Reading from file tmpfile_stdout 16:32:11 INFO - Detecting whether we're running mozinstall >=1.0... 16:32:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:32:11 INFO - Reading from file tmpfile_stdout 16:32:11 INFO - Output received: 16:32:11 INFO - Usage: mozinstall [options] installer 16:32:11 INFO - Options: 16:32:11 INFO - -h, --help show this help message and exit 16:32:11 INFO - -d DEST, --destination=DEST 16:32:11 INFO - Directory to install application into. [default: 16:32:11 INFO - "/builds/slave/test"] 16:32:11 INFO - --app=APP Application being installed. [default: firefox] 16:32:11 INFO - mkdir: /builds/slave/test/build/application 16:32:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:32:27 INFO - Reading from file tmpfile_stdout 16:32:27 INFO - Output received: 16:32:27 INFO - /builds/slave/test/build/application/firefox/firefox 16:32:27 INFO - Running post-action listener: _resource_record_post_action 16:32:27 INFO - [mozharness: 2016-10-11 23:32:27.701796Z] Finished install step (success) 16:32:27 INFO - [mozharness: 2016-10-11 23:32:27.702043Z] Running run-tests step. 16:32:27 INFO - Running pre-action listener: _resource_record_pre_action 16:32:27 INFO - Running main action method: run_tests 16:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:32:27 INFO - Python 2.7.3 16:32:27 INFO - Return code: 0 16:32:27 INFO - grabbing minidump binary from tooltool 16:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:27 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 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:32:27 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 16:32:27 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 16:32:27 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 16:32:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:32:27 INFO - Return code: 0 16:32:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:32:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:32:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:32:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:32:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 16:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 16:32:27 INFO - Using env: {'DISPLAY': ':0', 16:32:27 INFO - 'HOME': '/home/cltbld', 16:32:27 INFO - 'LANG': 'en_US.UTF-8', 16:32:27 INFO - 'LANGUAGE': 'en_US:en', 16:32:27 INFO - 'LOGNAME': 'cltbld', 16:32:27 INFO - 'MAIL': '/var/mail/cltbld', 16:32:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:32:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:27 INFO - 'MOZ_NO_REMOTE': '1', 16:32:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:27 INFO - 'NO_EM_RESTART': '1', 16:32:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:27 INFO - 'PWD': '/builds/slave/test', 16:32:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:32:27 INFO - 'SHELL': '/bin/bash', 16:32:27 INFO - 'SHLVL': '1', 16:32:27 INFO - 'TERM': 'linux', 16:32:27 INFO - 'TMOUT': '86400', 16:32:27 INFO - 'USER': 'cltbld', 16:32:27 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165', 16:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:27 INFO - '_': '/tools/buildbot/bin/python'} 16:32:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 16:32:27 INFO - mozversion application_buildid: 20161011134948 16:32:27 INFO - mozversion application_changeset: 22a929d86e4db43d828efe54430a34c182b2dbc2 16:32:27 INFO - mozversion application_display_name: Nightly 16:32:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:32:27 INFO - mozversion application_name: Firefox 16:32:27 INFO - mozversion application_remotingname: firefox 16:32:27 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 16:32:27 INFO - mozversion application_vendor: Mozilla 16:32:27 INFO - mozversion application_version: 52.0a1 16:32:27 INFO - mozversion platform_buildid: 20161011134948 16:32:27 INFO - mozversion platform_changeset: 22a929d86e4db43d828efe54430a34c182b2dbc2 16:32:27 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 16:32:27 INFO - mozversion platform_version: 52.0a1 16:32:27 INFO - using testdate: 1476228747 16:32:27 INFO - actual date: 1476228747 16:32:27 INFO - starting webserver on 'localhost:47228' 16:32:27 INFO - SUITE-START | Running 2 tests 16:32:27 INFO - TEST-START | dromaeo_css 16:32:27 INFO - operating with platform_type : linux_ 16:32:27 INFO - Initialising browser for dromaeo_css test... 16:32:27 INFO - TEST-INFO | started process 20449 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJzyEpU/profile http://localhost:47228/getInfo.html) 16:32:33 INFO - PROCESS | 20449 | __metrics Screen width/height:1600/1200 16:32:33 INFO - PROCESS | 20449 | colorDepth:24 16:32:33 INFO - PROCESS | 20449 | Browser inner width/height: 1024/697 16:32:33 INFO - PROCESS | 20449 | __metrics 16:32:33 ERROR - PROCESS | 20449 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 16:32:34 INFO - TEST-INFO | 20449: exit 0 16:32:34 INFO - Browser initialized. 16:32:34 INFO - Running cycle 1/1 for dromaeo_css test... 16:32:34 INFO - TEST-INFO | started process 20570 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJzyEpU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:46 INFO - PROCESS | 20570 | RSS: Main: 188030976 16:32:46 INFO - PROCESS | 20570 | 16:33:36 INFO - PROCESS | 20570 | 1476228816715 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] 16:35:50 INFO - PROCESS | 20570 | Cycle 1(1): loaded http://localhost:47228/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47228/tests/dromaeo/cssquery-ext.html) 16:35:51 INFO - PROCESS | 20570 | RSS: Main: 197705728 16:35:51 INFO - PROCESS | 20570 | 16:38:53 INFO - PROCESS | 20570 | Cycle 1(1): loaded http://localhost:47228/tests/dromaeo/cssquery-ext.html (next: http://localhost:47228/tests/dromaeo/cssquery-jquery.html) 16:38:54 INFO - PROCESS | 20570 | RSS: Main: 198705152 16:38:54 INFO - PROCESS | 20570 | 16:41:56 INFO - PROCESS | 20570 | Cycle 1(1): loaded http://localhost:47228/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47228/tests/dromaeo/cssquery-mootools.html) 16:41:57 INFO - PROCESS | 20570 | RSS: Main: 200495104 16:41:57 INFO - PROCESS | 20570 | 16:44:59 INFO - PROCESS | 20570 | Cycle 1(1): loaded http://localhost:47228/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47228/tests/dromaeo/cssquery-prototype.html) 16:44:59 INFO - PROCESS | 20570 | RSS: Main: 197492736 16:44:59 INFO - PROCESS | 20570 | 16:48:02 INFO - PROCESS | 20570 | Cycle 1(1): loaded http://localhost:47228/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47228/tests/dromaeo/cssquery-yui.html) 16:48:03 INFO - PROCESS | 20570 | RSS: Main: 200282112 16:48:03 INFO - PROCESS | 20570 | 16:51:06 INFO - PROCESS | 20570 | Cycle 1(1): loaded http://localhost:47228/tests/dromaeo/cssquery-yui.html (next: http://localhost:47228/tests/dromaeo/cssquery-dojo.html) 16:51:06 INFO - PROCESS | 20570 | RSS: Main: 201306112 16:51:06 INFO - PROCESS | 20570 | 16:51:06 INFO - PROCESS | 20570 | __start_tp_report 16:51:06 INFO - PROCESS | 20570 | _x_x_mozilla_page_load 16:51:06 INFO - PROCESS | 20570 | _x_x_mozilla_page_load_details 16:51:06 INFO - PROCESS | 20570 | |i|pagename|runs| 16:51:06 INFO - PROCESS | 20570 | |0;dojo.html;2565.461253136841;2586.4309851832595;2591.080166540878;2597.0520759922633;2636.2486691292975;4494.25844735619;4607.193741095303;4658.604018658418;4684.882877928049;4714.858554243369;4629.16674998501;4632.5135860734645;4693.953060469403;4734.289856521524;4747.715137091777;4291.892702682435;4319.935200971988;4352.107817897323;4374.03771170342;4430.889227769316;4327.826886924519;4331.8700438986725;4381;4406.096750166224;4421;4221.409002739619;4264.658827293809;4292.12011537634;4394.824207031715;4416.381706561084;4320.848770293024;4340.804663790105;4348.826046958118;4402.625776808975;4403.3174857897075;4284.250256205151;4311.892202694927;4331.415258940035;4358.368036634702;4383.101464199864;4543.477500087499;4581.1753884300815;4686.08621318843;4717.882052948669;4763.261694437368;4954.058728841508;4964.528369804862;4969.701817890938;4971.950280497221;4975.427825800043;4940.901181976376;5004.3994720633755;5087.26234695967;5091.032703786269;5178.223266510016;4742.857714268577;4750.762461876892;4753;4760.857174284777;4809.78355973982;5204.141316682781;5221.530062294411;5228.660137091077;5232.529072383504;5275.973620131952;4838.080764654775;4854.101991131652;4912.508749125059;4975.875603109879;4977.402711674622;4936.407631084293;5039.798408063636;5046.091703493406;5049.040682270357;5063.13926632466;4954.355933728664;5017.724025178651;5026.271190677331;5030.522100400456;5036.874078148076;4984.3021976923255;4996.325496058058;5008.474110218374;5013.24801279811;5065.924011139836;3869;3870.4000879863665;3926.1362500249897;3944.456820375756;3996.1008773025837;3421.298633780069;3445.2248244144866;3478.043538027063;3486.1981744198974;3491.4762785582366;4311.051568654891;4337.8264869404875;4344.174606824693;4347.152305300436;4397.1205758848355;4899.583535399531;4942.827001055018;4986.052649996562;5013.548780609763;5034.697918124924;4355.1725172217175;4384.714993525411;4389.407429996973;4411.338299255073;4463.018136010072;4502.977485112619;4505.6846020778885;4516.345129956138;4518.593326600556;4581.633469322446;4654.837080702159;4808.903821923612;4813.422389313305;4835.347228124158;4878.341423907798;4937.382827146606;4948.554630083309;4958.528939750718;5017.172166592617;5054.393472783143;4710.8351207707565;4711.363965864564;4720.268358404453;4725.29120631908;4785.353977213032;4758.04839032188;4850.054239423279;4906.484819093944;4921.581665558468;4981;5051.888584511402;5077.213031980049;5092.490750924878;5129.153689641167;5148.58811295103;4927.285543596086;4927.334809800775;4929.950700492949;4960.305557222064;5001.624878134227;4812.446568644511;4836.516348365135;4868.634852386014;4923.655344125877;4957.752112394293;4759.357486739246;4817.325574419654;4826.541478559531;4854.126257273725;4863.878403039811;4895.534924182197;4902.779374928208;4918.827841025547;4931.9753401232765;4987.825426110068;4768.189407800613;4814.277858321279;4814.831480898151;4819;4876.658633895735 16:51:06 INFO - PROCESS | 20570 | |1;ext.html;529.7457220534146;543.8912217556489;544.5181014801899;544.9019176548221;553.3277068361939;38370.808145959265;40189.3971590426;40248;40251.39622905652;40259;41383.79308103455;42032;42044.846636502305;42400.57599424005;42405.57594424055;7470.626468676558;7532.284432978859;7541.811454713621;7548.886766698504;7606.315431611154;7684.615769211545;7781.8832717509285;7788.104367997667;7790.5325680459355;7796.6491507882;7733.922660773376;7773;7831.295183433518;7863.685452581918;7874.724384646539;7723.53658780475;7739.380849532024;7761.689532418753;7763.301302882711;7768.844623107534;7652.426068044919;7751.418643601753;7765.883511747328;7769.223077692242;7772.455928085036;38110.618893810984;38412.23175536474;38439.423408648894;38640.22719545622;38731.612683873085;2881.884724611013;2888.956665650017;2916.7554813092715;2928.677845437;2958.511845545504;27128.45743085147;27997.440051199064;28448.28879278014;29021.274468138254;29078.41843163146;3298.4392653249006;3330.1008727643643;3355.0605830367535;3368.1074515253476;3378.7803792753393;157656;158947;159019;160898;160960.19519902443;54057.45942540524;54303.99999999921;54517.91267135247;54641.1803822943;54830.45169548333;56800.307979982;57171;57240.713796431584;57275;57323.42676573181;14026.509072182425;14295.142291462545;14311.499097531536;14320.928395357956;14382.568522944328;10552.419616921143;10727.249092563601;10738.94630526858;10766.461676916122;10769.515371808287;17014.829851701572;17745.46763597094;17816.46550603484;17845.46463606094;18082.649255596953;6619.801405957829;6645.833854153685;6696.497762667819;6734.050408094024;6998.510104292753;775.8525880082766;918.9310801689767;936.9344145909857;943.1605870775015;944.0465130218391;27709.86145069302;28175.71824281772;28223.858880705466;28596.571051434246;28886.42227155487;924.7532915158198;963.1620490173594;965.7199412170391;1020.5254556631054;1033.617561502249;14625.488107916171;15135.545933622008;15195.316210770541;15897.52307430779;16500.33998640065;388398;391689;392116;392119;393239;50175.74912125416;50630.24054639183;50702.239466408035;50766.74616626893;50818.237726434134;1155.589765633205;1171.3264872698062;1186.371223251678;1187.679326581818;1195.8266051422495;27481.31296717598;28781;29322.387268700426;29403.85298073496;29453.85273073621;41262.38106428346;41598.37602435905;41938.16123677448;42043.1591368177;42060;314608;318415;318475;318534;318976;25554.616680750176;25603.615945760455;25717.35706607275;25755.871220643778;25923.740762592886;40634.390484143354;41435.585644143175;42047;43338.78330608327;45614.543854562355;36253.818730906176;36681.44977825388;36719;36892.26215475729;37499.81250093732;36427.63572364242;36700.81649591735;36820.63179368172;37396.6260337404;37518.06204844901;35375.646243538264;35789;36163;36294.8185259072;36649;31014.68985310208;33244.83377583193;33253.33493330071;33394.666053339155;33443.163920902174;25471.872640636677;25711.871440642677;25792.355191119623;25848.612270815578;26069.608955865297 16:51:06 INFO - PROCESS | 20570 | |2;jquery.html;345.1560933517549;359.489524874678;361.5607037449498;366.3021943198205;376.1818045750494;14817.851821481796;15188.84811151888;16376.263068161932;16495;16645;11749.588764393227;13876.861231387684;15678.529644110666;15704.214789260519;16487.670246595062;4934.925976110361;5201.219817027457;5210.140326846066;5212.322398088262;5217.37391513019;4915.557599816016;5068.239764035406;5125.154349532323;5139.203423469368;5142.331496905397;5093.26147708582;5126.436092029874;5130.538251557359;5142.07442660321;5144.22836574515;4957.900841983176;5109.616778741591;5114.590832733373;5117.948820511784;5128.025675121715;4565.178267911774;4578.702384345007;4609.539046095397;4612.215923293048;4617.676762626617;19126.90436547822;19569.21723131087;19669.901650491654;19703.80296197034;19995.900020499805;1694.3730819596706;1832.844208242301;1914.5213696575856;1921.567647279365;2287.2223444028946;5097.439281679012;5154.226865970097;5189.792408303663;9105.954470227607;9296.116868897443;1664.6837100950781;1760.7622970898892;1777.1558509707916;1811.538057795267;1822.7812662480587;66635;67580;67857.66071169662;68044;68807;8081.353491720648;8536.914630853737;8651.610677519528;8737.956310218407;9060.456372617664;10765.3540787553;10826;10870.673879783619;10883.129349652008;10944.616938407118;5981.192539007266;6318.115463835067;6685.765998190137;6811.659417029129;7078.150621925299;6590.703418346186;6843.623600702009;6882.105326307548;6896.551724137915;7001.964990175016;3740.8877733668032;3765.9058523536582;3834.405667121601;3849.557300910375;3902.6292502212245;1614.1767698473627;1660.4603503861051;1725.3961113610137;1763.8853474524115;1851.3705340184133;784.5880912520859;814.3444527155578;909.6270529083044;938.216589148069;952.9904700953041;16014.839851601335;16138.112403817902;16374.83625163757;16531.256093475822;16947.830521694872;817.8037271055023;830.7258604660448;832.4672209785742;848.2789628815458;849.592195746033;8720.694775682821;9515.619375225051;9541.618335266512;9580.760480987892;9655.565499552536;373853;383278;391804;394288;397518;74762;77826;79061.41877162424;79373;79653.4155962983;873.947563146226;888.4846788862444;908.8909330880336;915.5102020419178;915.9679411220575;13938.721225575635;14956.626084347543;14974.176420296988;15257.237138143271;15297.46458873934;37357.6264237365;37646.24707505889;37877.05307367338;38184;38456.807715961244;46225.306620401396;46730.29904551502;47688.52311476841;50163.74918125386;50430.49569504258;5071.54356107952;5083.542481176712;6988.336108069725;7559.1306999695735;7755.689772409266;9975.703158589627;10154.796904062025;10361.4301213434;11043.39261340634;11098.778024439305;8920.464772113693;9162.816743664956;9326.347155699035;9340.439573625605;9863.063009014133;9527.809443810946;9777.755556111155;9945.104940555384;9953.701388958343;10047.09576138151;9694.369865958972;10064.597416103274;10106.242031847494;10373.740656483647;10615.150787936793;7471.663775130023;7523.360514356122;7604.923950760422;7637.045369328834;7763.68945242184;8511.446755960842;9490.28822838276;9662.516874156123;9702.812047350395;10358.274920755475 16:51:06 INFO - PROCESS | 20570 | |3;mootools.html;1201.6335017819567;1272.5238723081222;1311.7704401729695;1612.8306527814586;1619.465576359802;6340.524460665457;6556.672166391673;6950.478714096444;7440.367568756656;7461.477696561243;6989.930100698992;7310.744123955663;7312.561246325211;7496.962515187416;7514.549127052367;2069.772325044244;2097.2449918029574;2097.4336929029155;2100.7584127825344;2103.2323202031225;2072.1504183284856;2091.979080209201;2097.800708932649;2112.6830975353664;2120.872747635147;2056.897155142244;2063.731714877071;2064.07116797441;2069.7412823397076;2072.2332736887374;1979.3863902190367;1985.7418535590425;1989.6717041688105;1990.2138655231247;1996.5208349996042;1984.6130004649099;1989.7711763147279;2026.5744193719336;2027.5843452092286;2036.857419980587;7012.929870701279;7130.144382674061;7176.3182497663165;7201.783946481614;7212.603306818123;4248.702590818644;4339.457567804025;4366.432363792686;4371.082072764723;4375.2124617568825;2754.394033312668;2814.1979535832393;2839.2475993861644;2866.011226126983;2873.726995935404;867.9783005424852;871.6295574380863;885.198895000026;885.716570697377;897.1970086772368;9774.16919561838;9785.657501987396;9840.901590984071;9884.308098433112;9898.752531186707;3608.8376023079027;3676.2647470506004;3815.790131542736;3830.6552410283207;3843.1737176507186;7704.537727736354;7726.266004729542;7730.458867879307;7731.188225236382;7731.458797884206;4232.25935461293;4247.0444150066605;4247.214265360918;4251.383549385322;4254.361845723104;3375.1224681582967;3491.4064609016527;3801.923961520754;3905.5508616508896;3922.5489068756888;3153.0856051744736;3201.791883527563;3321.9501707474406;3338.532605435241;3341.2482191506715;970.3498655900563;994.3139233928566;996.940183588987;1003.3678782367062;1003.934744241622;749.2058418076856;777.6850375597892;783.3263393481601;798.7683571764123;801.2628381888676;4687.67186296956;4720.150372932836;4820.325154478376;4824.589909857631;4969.90060198794;398.38847369288004;408.7792592000346;414.1633899523007;414.5833437395398;416.69581205719993;3173.984130079335;3310.0731795097413;3318.021183750799;3327.8502467389026;3344.782589131699;8433.662653493915;8607.22534971843;8762.38663293576;8881.200691937756;8893.421927574687;8672.219500245008;8722.694705685271;8726.86909696355;8729.51987640686;8760.912390876138;6417.550771445954;6825.9317406826285;6886.793396198122;6919.4464442844455;6924.861502769916;4695.248760198352;4914.606831453547;5012.974935125301;5027.547520723152;5168.793248270027;7992.800179995546;8122.837543248984;8202.548859812528;8278.71024514139;8355.456895301786;8058.194180581895;8264.462809917337;8285.62714677853;8338.833223335621;8373;6115.755369785336;6232.314445410911;6334.524910631813;6362.395572420613;6378.840528986627;7073.328033836778;7147.499675022907;7150;7153.642317884189;7177.031100801325;6086.2087928569;6131.754729810936;6305.40098690642;6357.268914074755;6440.710168042356;6259.812205633838;6275.34108918557;6278.434940855345;6305.085762564494;6312.274088479883;5867.413258674099;5874.619464425771;5904.498117660047;5910.970445147746;5925.348211696796;4124.237016151901;4130.463039804806;4216.873493795191;4222;4283.164782867311;3979.144483935968;4060.6548443382644;4063.431119643193;4084.571120032354;4199.9370009450495 16:51:06 INFO - PROCESS | 20570 | |4;prototype.html;291.6820665474633;293.2141859815693;295.7545237452914;299.492360449039;307.1675758693939;4895.804167833291;4942.802287908484;4966.453690094096;4967.751612419378;5004.5987123605355;4879.414470263573;4879.70721756694;4891.926621100686;4892.266160075981;4909.656324057318;3669.743117981742;3747.812609369534;3765.7740535567955;3859.2281543691233;3870.845166193349;3812.7902965336893;3819.828107735145;3833.616638336158;3834.980825095871;3845.5193100862393;3806.5622453417936;3825.6227758007094;3833.8658146964863;3865.1303456722294;3883.766973981556;3791.658750712449;3879.243547508237;3885.338543097973;3885.436611691317;3886.727929044968;3379.7803142795638;3385.881494147693;3393.573594879648;3400.96599034009;3421.367047096295;4720.716756994557;4769.332293478916;4770.189067858472;4779.545943135397;4806.495317991596;4378;4393.231184542724;4407.757573333465;4410.933835992462;4414.80133393998;5090.872728181788;5153.665011774223;5169.302144210521;5173.198154286091;5183.067047931371;3749.3063783199923;3749.5875453700073;3752.5309336332957;3762.49206357141;3764.5106136202394;5347.598930080259;5370.301860758115;5447.673139611636;5451.628541584463;5477.4248703886315;3705.1478160022807;3770.245950809849;3802.5056742623283;3847.5382954045135;3859.9421008684894;3820.7707537547835;3837.136644255076;3837.808109594509;3845.692344612424;3856.1902000580194;4269.188854117708;4342.652587792969;4355.891102722458;4359.125576002286;4376.387305777193;4893.584045356185;5115.335006449138;5129.846104616868;5134.589232861362;5167.173252279692;1334.3928512526777;1363.9931800340935;1364.979525307121;1365.7268546290782;1370.1984339161502;857.9013413457408;885.9246964008131;886.1802832380023;897.0625696147541;902.3412908576776;4066.9389959150635;4073.8574149905203;4378.978105109518;4487.439070116236;4541.318802179633;5315.73421328932;5331.226972089103;5342.706151161646;5347.81282655113;5348.705821179872;4598.471175814824;4602.631789456836;4603.792829322689;4614.2617181250835;4631.675782695246;2801.6272026706765;2841.1760589429246;2843.957340639892;2855.5436727269243;2861.570764385359;5064.7214403207445;5080.441151473335;5092.38891333035;5094.465081166498;5098.643094983389;5439.857629897687;5454.154606036071;5470.316210473691;5481.382287690106;5497.780088796483;4805.879853003633;4972.254161875748;5008.923081537487;5015.423226329019;5033.5721463676;5274.868128296824;5310.822562749254;5323.866903327293;5330.227117068081;5334.199870019373;4967.329410529676;5162.277281180713;5166.715830629351;5176.534111929794;5190.2214667800135;4966.329545511309;5005.449400566008;5013.373328333958;5015.2978582997675;5019.67372120811;3857.4213867920034;3867.43922131295;3867.555231148454;3872.574016858087;3883.572806991172;5151.519668490205;5384.838454846361;5393.002294575516;5401.783928642811;5409;5120.385553733576;5150.201718733602;5159.484051594811;5159.767810448614;5166.354205724285;5081.415637201769;5150.716710580954;5155.200943853709;5157.793688252428;5171.767270472763;4973.45292017885;5052.269967719917;5088.185890257541;5105.310783044241;5127.435982042047;4898.730569818694;5094.7962081516325;5171.63798534099;5177.249298851721;5201.921971170511;4943.752812359296;4949.232868905326;5090.211017292326;5120.846374608767;5121.359830021247 16:51:06 INFO - PROCESS | 20570 | |5;yui.html;554.5868328095567;574.7787101965741;582.3448620302161;642.8874946884297;664.4153145232196;11502.597409090684;12210.633680989562;12250.632481025561;12264.999999999989;12450.875491245097;11869.940650296758;12093.758124837519;12097.818532722016;12107.576234831782;12115.212511186766;536.8792021795103;722.9638518074102;745.5340412242349;750.7822731407886;754.1591125894643;552.6269767906667;727.6434547071923;740.3152084322007;752.6989204318289;755.4975940999229;791.6160662078887;792.5165648954134;793.0245797668871;794.1978601612356;796.6136423834436;779.286952438518;782.6634547144726;784.4116912315792;785.35600807338;787.7400457848896;584.1208980484387;584.433099893103;584.8391692284613;585.0843430031987;586.9677167755772;11873.94063029688;11877.049836013099;11886.167968242227;11889.108316876269;11949.581764638197;12002;12137.029037677054;12408;12458.75082498345;12962.416691248916;10016.649417270433;10024.448655323955;10078.244131690079;10089.394636321844;10170.338927969733;3174.9206269843207;3238.805671659708;3254.479283314682;3255.9348813023844;3354.681305275995;60268.39731602672;60382.698086509285;60554.69722651403;61325;61546.69226653883;9776.169025632758;9918.40489570628;10036.749081273027;10064.44645544502;10287.794244115075;17392.21735021927;17421.303147874198;17448.12759362027;17502.299908003537;17518.737218941726;6246.531510136758;6358.237011558643;6370;6444.484441244689;6491.285958544557;3165.9525107123413;3229.935401291961;3286.2277364819247;3301.3562355340478;3330.4338262495435;2574.871256437171;2726.7954903382324;2753.7108603596735;2756.8759405826786;2757.310672331917;467.0938379543674;467.25706127257826;474.3572459317644;475.7240800335797;479.38399157082983;427.4763414816887;476.9713817170981;508.6846155383686;521.3847659761442;527.4751622135923;7571.507851989603;7598.734044308423;7640.961795190989;7704.5762483062845;7884.448088633855;468.2461237407771;541.8401571536406;556.2018503447484;567.2398985359638;575.9747649184459;3371.7976921384798;3556.0043187907427;3601.505375269286;3696.464012718141;3802.448644946467;50406.49593504018;51423.22865157026;74081;84191.5790421044;87726.56136719276;45123.097538049056;45781.31328030082;46998.76500617475;54585;62207.6889615549;42663.7866810664;55245.723771380886;68179.65910170418;71414.64292678503;71772.99999999895;6983.3714965653335;6999;7124.501284910214;7172.282771722786;7310.561366318038;40966.9758256046;41695.7915210422;41845.372319415845;42190.789046054575;42862.78568607137;55502.72248638731;55884.44115558793;57619.423805761406;61201;61276;9183.173514383738;9587.808243835223;9709.320347575602;9945.801083978424;10019.649312274036;10089.041541053588;10161.479333426;10208.556574195294;10261.639822840938;10442.582296708351;9234.584443700183;9380.57787399555;9408.43549387039;9418.481983490974;9491.715248542554;9332.160105590257;9361.157495825408;9496.43021418717;9521.714348569554;9580.329376943826;9018;9126.954365228132;9175.357724959189;9176.724698259062;9196.816063678823;8241.50550966944;8375.664973400995;8466.195711407407;8484.91515084866;8599.484030958163;7893.526388416713;7896.447248692536;8175.509469431853;8500;9028.909710902806 16:51:06 INFO - PROCESS | 20570 | __end_tp_report 16:51:06 INFO - PROCESS | 20570 | __start_cc_report 16:51:06 INFO - PROCESS | 20570 | _x_x_mozilla_cycle_collect,330 16:51:06 INFO - PROCESS | 20570 | __end_cc_report 16:51:06 INFO - PROCESS | 20570 | __startTimestamp1476229866362__endTimestamp 16:51:06 INFO - PROCESS | 20570 | 16:51:06 INFO - PROCESS | 20570 | ------- Summary: start ------- 16:51:06 INFO - PROCESS | 20570 | Number of tests: 6 16:51:06 INFO - PROCESS | 20570 | 16:51:06 INFO - PROCESS | 20570 | [#0] dojo.html Cycles:165 Average:4631.31 Median:4785.35 stddev:515.75 (10.8%) stddev-sans-first:491.21 16:51:06 INFO - PROCESS | 20570 | Values: 2565.5 2586.4 2591.1 2597.1 2636.2 4494.3 4607.2 4658.6 4684.9 4714.9 4629.2 4632.5 4694.0 4734.3 4747.7 4291.9 4319.9 4352.1 4374.0 4430.9 4327.8 4331.9 4381.0 4406.1 4421.0 4221.4 4264.7 4292.1 4394.8 4416.4 4320.8 4340.8 4348.8 4402.6 4403.3 4284.3 4311.9 4331.4 4358.4 4383.1 4543.5 4581.2 4686.1 4717.9 4763.3 4954.1 4964.5 4969.7 4972.0 4975.4 4940.9 5004.4 5087.3 5091.0 5178.2 4742.9 4750.8 4753.0 4760.9 4809.8 5204.1 5221.5 5228.7 5232.5 5276.0 4838.1 4854.1 4912.5 4975.9 4977.4 4936.4 5039.8 5046.1 5049.0 5063.1 4954.4 5017.7 5026.3 5030.5 5036.9 4984.3 4996.3 5008.5 5013.2 5065.9 3869.0 3870.4 3926.1 3944.5 3996.1 3421.3 3445.2 3478.0 3486.2 3491.5 4311.1 4337.8 4344.2 4347.2 4397.1 4899.6 4942.8 4986.1 5013.5 5034.7 4355.2 4384.7 4389.4 4411.3 4463.0 4503.0 4505.7 4516.3 4518.6 4581.6 4654.8 4808.9 4813.4 4835.3 4878.3 4937.4 4948.6 4958.5 5017.2 5054.4 4710.8 4711.4 4720.3 4725.3 4785.4 4758.0 4850.1 4906.5 4921.6 4981.0 5051.9 5077.2 5092.5 5129.2 5148.6 4927.3 4927.3 4930.0 4960.3 5001.6 4812.4 4836.5 4868.6 4923.7 4957.8 4759.4 4817.3 4826.5 4854.1 4863.9 4895.5 4902.8 4918.8 4932.0 4987.8 4768.2 4814.3 4814.8 4819.0 4876.7 16:51:06 INFO - PROCESS | 20570 | 16:51:06 INFO - PROCESS | 20570 | [#1] ext.html Cycles:180 Average:45248.68 Median:37508.94 stddev:80730.87 (215.2%) stddev-sans-first:80887.52 16:51:06 INFO - PROCESS | 20570 | Values: 529.7 543.9 544.5 544.9 553.3 38370.8 40189.4 40248.0 40251.4 40259.0 41383.8 42032.0 42044.8 42400.6 42405.6 7470.6 7532.3 7541.8 7548.9 7606.3 7684.6 7781.9 7788.1 7790.5 7796.6 7733.9 7773.0 7831.3 7863.7 7874.7 7723.5 7739.4 7761.7 7763.3 7768.8 7652.4 7751.4 7765.9 7769.2 7772.5 38110.6 38412.2 38439.4 38640.2 38731.6 2881.9 2889.0 2916.8 2928.7 2958.5 27128.5 27997.4 28448.3 29021.3 29078.4 3298.4 3330.1 3355.1 3368.1 3378.8 157656.0 158947.0 159019.0 160898.0 160960.2 54057.5 54304.0 54517.9 54641.2 54830.5 56800.3 57171.0 57240.7 57275.0 57323.4 14026.5 14295.1 14311.5 14320.9 14382.6 10552.4 10727.2 10738.9 10766.5 10769.5 17014.8 17745.5 17816.5 17845.5 18082.6 6619.8 6645.8 6696.5 6734.1 6998.5 775.9 918.9 936.9 943.2 944.0 27709.9 28175.7 28223.9 28596.6 28886.4 924.8 963.2 965.7 1020.5 1033.6 14625.5 15135.5 15195.3 15897.5 16500.3 388398.0 391689.0 392116.0 392119.0 393239.0 50175.7 50630.2 50702.2 50766.7 50818.2 1155.6 1171.3 1186.4 1187.7 1195.8 27481.3 28781.0 29322.4 29403.9 29453.9 41262.4 41598.4 41938.2 42043.2 42060.0 314608.0 318415.0 318475.0 318534.0 318976.0 25554.6 25603.6 25717.4 25755.9 25923.7 40634.4 41435.6 42047.0 43338.8 45614.5 36253.8 36681.4 36719.0 36892.3 37499.8 36427.6 36700.8 36820.6 37396.6 37518.1 35375.6 35789.0 36163.0 36294.8 36649.0 31014.7 33244.8 33253.3 33394.7 33443.2 25471.9 25711.9 25792.4 25848.6 26069.6 16:51:06 INFO - PROCESS | 20570 | 16:51:06 INFO - PROCESS | 20570 | [#2] jquery.html Cycles:180 Average:23654.23 Median:5088.40 stddev:64204.15 (1261.8%) stddev-sans-first:64360.41 16:51:06 INFO - PROCESS | 20570 | Values: 345.2 359.5 361.6 366.3 376.2 14817.9 15188.8 16376.3 16495.0 16645.0 11749.6 13876.9 15678.5 15704.2 16487.7 4934.9 5201.2 5210.1 5212.3 5217.4 4915.6 5068.2 5125.2 5139.2 5142.3 5093.3 5126.4 5130.5 5142.1 5144.2 4957.9 5109.6 5114.6 5117.9 5128.0 4565.2 4578.7 4609.5 4612.2 4617.7 19126.9 19569.2 19669.9 19703.8 19995.9 1694.4 1832.8 1914.5 1921.6 2287.2 5097.4 5154.2 5189.8 9106.0 9296.1 1664.7 1760.8 1777.2 1811.5 1822.8 66635.0 67580.0 67857.7 68044.0 68807.0 8081.4 8536.9 8651.6 8738.0 9060.5 10765.4 10826.0 10870.7 10883.1 10944.6 5981.2 6318.1 6685.8 6811.7 7078.2 6590.7 6843.6 6882.1 6896.6 7002.0 3740.9 3765.9 3834.4 3849.6 3902.6 1614.2 1660.5 1725.4 1763.9 1851.4 784.6 814.3 909.6 938.2 953.0 16014.8 16138.1 16374.8 16531.3 16947.8 817.8 830.7 832.5 848.3 849.6 8720.7 9515.6 9541.6 9580.8 9655.6 373853.0 383278.0 391804.0 394288.0 397518.0 74762.0 77826.0 79061.4 79373.0 79653.4 873.9 888.5 908.9 915.5 916.0 13938.7 14956.6 14974.2 15257.2 15297.5 37357.6 37646.2 37877.1 38184.0 38456.8 46225.3 46730.3 47688.5 50163.7 50430.5 5071.5 5083.5 6988.3 7559.1 7755.7 9975.7 10154.8 10361.4 11043.4 11098.8 8920.5 9162.8 9326.3 9340.4 9863.1 9527.8 9777.8 9945.1 9953.7 10047.1 9694.4 10064.6 10106.2 10373.7 10615.2 7471.7 7523.4 7604.9 7637.0 7763.7 8511.4 9490.3 9662.5 9702.8 10358.3 16:51:06 INFO - PROCESS | 20570 | 16:51:06 INFO - PROCESS | 20570 | [#3] mootools.html Cycles:180 Average:4715.32 Median:5098.17 stddev:2636.77 (51.7%) stddev-sans-first:2630.95 16:51:06 INFO - PROCESS | 20570 | Values: 1201.6 1272.5 1311.8 1612.8 1619.5 6340.5 6556.7 6950.5 7440.4 7461.5 6989.9 7310.7 7312.6 7497.0 7514.5 2069.8 2097.2 2097.4 2100.8 2103.2 2072.2 2092.0 2097.8 2112.7 2120.9 2056.9 2063.7 2064.1 2069.7 2072.2 1979.4 1985.7 1989.7 1990.2 1996.5 1984.6 1989.8 2026.6 2027.6 2036.9 7012.9 7130.1 7176.3 7201.8 7212.6 4248.7 4339.5 4366.4 4371.1 4375.2 2754.4 2814.2 2839.2 2866.0 2873.7 868.0 871.6 885.2 885.7 897.2 9774.2 9785.7 9840.9 9884.3 9898.8 3608.8 3676.3 3815.8 3830.7 3843.2 7704.5 7726.3 7730.5 7731.2 7731.5 4232.3 4247.0 4247.2 4251.4 4254.4 3375.1 3491.4 3801.9 3905.6 3922.5 3153.1 3201.8 3322.0 3338.5 3341.2 970.3 994.3 996.9 1003.4 1003.9 749.2 777.7 783.3 798.8 801.3 4687.7 4720.2 4820.3 4824.6 4969.9 398.4 408.8 414.2 414.6 416.7 3174.0 3310.1 3318.0 3327.9 3344.8 8433.7 8607.2 8762.4 8881.2 8893.4 8672.2 8722.7 8726.9 8729.5 8760.9 6417.6 6825.9 6886.8 6919.4 6924.9 4695.2 4914.6 5013.0 5027.5 5168.8 7992.8 8122.8 8202.5 8278.7 8355.5 8058.2 8264.5 8285.6 8338.8 8373.0 6115.8 6232.3 6334.5 6362.4 6378.8 7073.3 7147.5 7150.0 7153.6 7177.0 6086.2 6131.8 6305.4 6357.3 6440.7 6259.8 6275.3 6278.4 6305.1 6312.3 5867.4 5874.6 5904.5 5911.0 5925.3 4124.2 4130.5 4216.9 4222.0 4283.2 3979.1 4060.7 4063.4 4084.6 4199.9 16:51:06 INFO - PROCESS | 20570 | 16:51:06 INFO - PROCESS | 20570 | [#4] prototype.html Cycles:180 Average:4291.04 Median:4894.69 stddev:1239.30 (25.3%) stddev-sans-first:1205.88 16:51:06 INFO - PROCESS | 20570 | Values: 291.7 293.2 295.8 299.5 307.2 4895.8 4942.8 4966.5 4967.8 5004.6 4879.4 4879.7 4891.9 4892.3 4909.7 3669.7 3747.8 3765.8 3859.2 3870.8 3812.8 3819.8 3833.6 3835.0 3845.5 3806.6 3825.6 3833.9 3865.1 3883.8 3791.7 3879.2 3885.3 3885.4 3886.7 3379.8 3385.9 3393.6 3401.0 3421.4 4720.7 4769.3 4770.2 4779.5 4806.5 4378.0 4393.2 4407.8 4410.9 4414.8 5090.9 5153.7 5169.3 5173.2 5183.1 3749.3 3749.6 3752.5 3762.5 3764.5 5347.6 5370.3 5447.7 5451.6 5477.4 3705.1 3770.2 3802.5 3847.5 3859.9 3820.8 3837.1 3837.8 3845.7 3856.2 4269.2 4342.7 4355.9 4359.1 4376.4 4893.6 5115.3 5129.8 5134.6 5167.2 1334.4 1364.0 1365.0 1365.7 1370.2 857.9 885.9 886.2 897.1 902.3 4066.9 4073.9 4379.0 4487.4 4541.3 5315.7 5331.2 5342.7 5347.8 5348.7 4598.5 4602.6 4603.8 4614.3 4631.7 2801.6 2841.2 2844.0 2855.5 2861.6 5064.7 5080.4 5092.4 5094.5 5098.6 5439.9 5454.2 5470.3 5481.4 5497.8 4805.9 4972.3 5008.9 5015.4 5033.6 5274.9 5310.8 5323.9 5330.2 5334.2 4967.3 5162.3 5166.7 5176.5 5190.2 4966.3 5005.4 5013.4 5015.3 5019.7 3857.4 3867.4 3867.6 3872.6 3883.6 5151.5 5384.8 5393.0 5401.8 5409.0 5120.4 5150.2 5159.5 5159.8 5166.4 5081.4 5150.7 5155.2 5157.8 5171.8 4973.5 5052.3 5088.2 5105.3 5127.4 4898.7 5094.8 5171.6 5177.2 5201.9 4943.8 4949.2 5090.2 5120.8 5121.4 16:51:06 INFO - PROCESS | 20570 | 16:51:06 INFO - PROCESS | 20570 | [#5] yui.html Cycles:180 Average:14826.48 Median:571.01 stddev:20140.04 (3527.1%) stddev-sans-first:20168.03 16:51:06 INFO - PROCESS | 20570 | Values: 554.6 574.8 582.3 642.9 664.4 11502.6 12210.6 12250.6 12265.0 12450.9 11869.9 12093.8 12097.8 12107.6 12115.2 536.9 723.0 745.5 750.8 754.2 552.6 727.6 740.3 752.7 755.5 791.6 792.5 793.0 794.2 796.6 779.3 782.7 784.4 785.4 787.7 584.1 584.4 584.8 585.1 587.0 11873.9 11877.0 11886.2 11889.1 11949.6 12002.0 12137.0 12408.0 12458.8 12962.4 10016.6 10024.4 10078.2 10089.4 10170.3 3174.9 3238.8 3254.5 3255.9 3354.7 60268.4 60382.7 60554.7 61325.0 61546.7 9776.2 9918.4 10036.7 10064.4 10287.8 17392.2 17421.3 17448.1 17502.3 17518.7 6246.5 6358.2 6370.0 6444.5 6491.3 3166.0 3229.9 3286.2 3301.4 3330.4 2574.9 2726.8 2753.7 2756.9 2757.3 467.1 467.3 474.4 475.7 479.4 427.5 477.0 508.7 521.4 527.5 7571.5 7598.7 7641.0 7704.6 7884.4 468.2 541.8 556.2 567.2 576.0 3371.8 3556.0 3601.5 3696.5 3802.4 50406.5 51423.2 74081.0 84191.6 87726.6 45123.1 45781.3 46998.8 54585.0 62207.7 42663.8 55245.7 68179.7 71414.6 71773.0 6983.4 6999.0 7124.5 7172.3 7310.6 40967.0 41695.8 41845.4 42190.8 42862.8 55502.7 55884.4 57619.4 61201.0 61276.0 9183.2 9587.8 9709.3 9945.8 10019.6 10089.0 10161.5 10208.6 10261.6 10442.6 9234.6 9380.6 9408.4 9418.5 9491.7 9332.2 9361.2 9496.4 9521.7 9580.3 9018.0 9127.0 9175.4 9176.7 9196.8 8241.5 8375.7 8466.2 8484.9 8599.5 7893.5 7896.4 8175.5 8500.0 9028.9 16:51:06 INFO - PROCESS | 20570 | -------- Summary: end -------- 16:51:06 INFO - PROCESS | 20570 | 16:51:07 INFO - TEST-INFO | 20570: exit 0 16:51:07 INFO - TEST-OK | dromaeo_css | took 1119526ms 16:51:07 INFO - TEST-START | kraken 16:51:07 INFO - operating with platform_type : linux_ 16:51:07 INFO - Initialising browser for kraken test... 16:51:07 INFO - TEST-INFO | started process 20931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJaSC0j/profile http://localhost:47228/getInfo.html) 16:51:12 INFO - PROCESS | 20931 | __metrics Screen width/height:1600/1200 16:51:12 INFO - PROCESS | 20931 | colorDepth:24 16:51:12 INFO - PROCESS | 20931 | Browser inner width/height: 1024/697 16:51:12 INFO - PROCESS | 20931 | __metrics 16:51:13 ERROR - PROCESS | 20931 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 16:51:13 INFO - TEST-INFO | 20931: exit 0 16:51:13 INFO - Browser initialized. 16:51:13 INFO - Running cycle 1/1 for kraken test... 16:51:13 INFO - TEST-INFO | started process 21053 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJaSC0j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:26 INFO - PROCESS | 21053 | RSS: Main: 187645952 16:51:26 INFO - PROCESS | 21053 | 16:51:29 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:47228/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47228/tests/kraken/driver.html?testName=audio-beat-detection) 16:51:30 INFO - PROCESS | 21053 | RSS: Main: 201478144 16:51:30 INFO - PROCESS | 21053 | 16:51:32 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:47228/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47228/tests/kraken/driver.html?testName=audio-dft) 16:51:33 INFO - PROCESS | 21053 | RSS: Main: 199475200 16:51:33 INFO - PROCESS | 21053 | 16:51:36 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:47228/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47228/tests/kraken/driver.html?testName=audio-fft) 16:51:37 INFO - PROCESS | 21053 | RSS: Main: 194908160 16:51:37 INFO - PROCESS | 21053 | 16:51:39 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:47228/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47228/tests/kraken/driver.html?testName=audio-oscillator) 16:51:40 INFO - PROCESS | 21053 | RSS: Main: 195821568 16:51:40 INFO - PROCESS | 21053 | 16:51:42 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:47228/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47228/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:51:42 INFO - PROCESS | 21053 | RSS: Main: 195710976 16:51:42 INFO - PROCESS | 21053 | 16:51:46 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:47228/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47228/tests/kraken/driver.html?testName=imaging-darkroom) 16:51:46 INFO - PROCESS | 21053 | RSS: Main: 195276800 16:51:46 INFO - PROCESS | 21053 | 16:51:50 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:47228/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47228/tests/kraken/driver.html?testName=imaging-desaturate) 16:51:50 INFO - PROCESS | 21053 | RSS: Main: 193896448 16:51:50 INFO - PROCESS | 21053 | 16:51:53 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:47228/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47228/tests/kraken/driver.html?testName=json-parse-financial) 16:51:54 INFO - PROCESS | 21053 | RSS: Main: 195178496 16:51:54 INFO - PROCESS | 21053 | 16:51:56 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:47228/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47228/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:51:56 INFO - PROCESS | 21053 | RSS: Main: 196059136 16:51:56 INFO - PROCESS | 21053 | 16:51:58 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:47228/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47228/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:51:59 INFO - PROCESS | 21053 | RSS: Main: 195260416 16:51:59 INFO - PROCESS | 21053 | 16:52:01 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:47228/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47228/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:52:02 INFO - PROCESS | 21053 | RSS: Main: 195850240 16:52:02 INFO - PROCESS | 21053 | 16:52:05 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:47228/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:52:06 INFO - PROCESS | 21053 | RSS: Main: 195751936 16:52:06 INFO - PROCESS | 21053 | 16:52:09 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:47228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:52:09 INFO - PROCESS | 21053 | RSS: Main: 195883008 16:52:09 INFO - PROCESS | 21053 | 16:52:11 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:47228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47228/tests/kraken/driver.html?testName=ai-astar) 16:52:11 INFO - PROCESS | 21053 | RSS: Main: 198529024 16:52:11 INFO - PROCESS | 21053 | 16:52:11 INFO - PROCESS | 21053 | __start_tp_report 16:52:11 INFO - PROCESS | 21053 | _x_x_mozilla_page_load 16:52:11 INFO - PROCESS | 21053 | _x_x_mozilla_page_load_details 16:52:11 INFO - PROCESS | 21053 | |i|pagename|runs| 16:52:11 INFO - PROCESS | 21053 | |0;ai-astar;109;114;114;114;115;115;115;115;116;116 16:52:11 INFO - PROCESS | 21053 | |1;audio-beat-detection;154;130;134;171;134;128;132;127;169;129 16:52:11 INFO - PROCESS | 21053 | |2;audio-dft;168;169;163;161;164;164;163;165;163;162 16:52:11 INFO - PROCESS | 21053 | |3;audio-fft;75;77;76;116;77;76;77;78;103;78 16:52:11 INFO - PROCESS | 21053 | |4;audio-oscillator;85;84;119;84;84;85;104;85;83;118 16:52:11 INFO - PROCESS | 21053 | |5;imaging-gaussian-blur;117;117;119;119;118;118;118;120;117;117 16:52:11 INFO - PROCESS | 21053 | |6;imaging-darkroom;149;149;150;152;151;150;153;151;150;146 16:52:11 INFO - PROCESS | 21053 | |7;imaging-desaturate;96;97;95;96;95;96;96;97;97;95 16:52:11 INFO - PROCESS | 21053 | |8;json-parse-financial;72;68;65;67;67;65;66;65;66;66 16:52:11 INFO - PROCESS | 21053 | |9;json-stringify-tinderbox;66;67;66;66;67;69;67;66;66;67 16:52:11 INFO - PROCESS | 21053 | |10;stanford-crypto-aes;84;84;84;84;85;84;86;85;95;90 16:52:11 INFO - PROCESS | 21053 | |11;stanford-crypto-ccm;152;139;143;144;144;143;142;151;186;153 16:52:11 INFO - PROCESS | 21053 | |12;stanford-crypto-pbkdf2;175;184;175;177;183;175;176;177;175;175 16:52:11 INFO - PROCESS | 21053 | |13;stanford-crypto-sha256-iterative;70;70;71;72;72;71;69;76;77;74 16:52:11 INFO - PROCESS | 21053 | __end_tp_report 16:52:11 INFO - PROCESS | 21053 | __start_cc_report 16:52:11 INFO - PROCESS | 21053 | _x_x_mozilla_cycle_collect,878 16:52:11 INFO - PROCESS | 21053 | __end_cc_report 16:52:11 INFO - PROCESS | 21053 | __startTimestamp1476229931724__endTimestamp 16:52:11 INFO - PROCESS | 21053 | 16:52:11 INFO - PROCESS | 21053 | ------- Summary: start ------- 16:52:11 INFO - PROCESS | 21053 | Number of tests: 14 16:52:11 INFO - PROCESS | 21053 | 16:52:11 INFO - PROCESS | 21053 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:2.00 (1.7%) stddev-sans-first:0.78 16:52:11 INFO - PROCESS | 21053 | Values: 109.0 114.0 114.0 114.0 115.0 115.0 115.0 115.0 116.0 116.0 16:52:11 INFO - PROCESS | 21053 | 16:52:11 INFO - PROCESS | 21053 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:134.00 stddev:17.20 (12.8%) stddev-sans-first:17.56 16:52:11 INFO - PROCESS | 21053 | Values: 154.0 130.0 134.0 171.0 134.0 128.0 132.0 127.0 169.0 129.0 16:52:11 INFO - PROCESS | 21053 | 16:52:11 INFO - PROCESS | 21053 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:2.53 (1.5%) stddev-sans-first:2.28 16:52:11 INFO - PROCESS | 21053 | Values: 168.0 169.0 163.0 161.0 164.0 164.0 163.0 165.0 163.0 162.0 16:52:11 INFO - PROCESS | 21053 | 16:52:11 INFO - PROCESS | 21053 | [#3] audio-fft Cycles:10 Average:83.30 Median:77.00 stddev:14.17 (18.4%) stddev-sans-first:14.71 16:52:11 INFO - PROCESS | 21053 | Values: 75.0 77.0 76.0 116.0 77.0 76.0 77.0 78.0 103.0 78.0 16:52:11 INFO - PROCESS | 21053 | 16:52:11 INFO - PROCESS | 21053 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:84.00 stddev:14.75 (17.6%) stddev-sans-first:15.35 16:52:11 INFO - PROCESS | 21053 | Values: 85.0 84.0 119.0 84.0 84.0 85.0 104.0 85.0 83.0 118.0 16:52:11 INFO - PROCESS | 21053 | 16:52:11 INFO - PROCESS | 21053 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.05 (0.9%) stddev-sans-first:1.05 16:52:11 INFO - PROCESS | 21053 | Values: 117.0 117.0 119.0 119.0 118.0 118.0 118.0 120.0 117.0 117.0 16:52:11 INFO - PROCESS | 21053 | 16:52:11 INFO - PROCESS | 21053 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.50 stddev:1.91 (1.3%) stddev-sans-first:1.99 16:52:11 INFO - PROCESS | 21053 | Values: 149.0 149.0 150.0 152.0 151.0 150.0 153.0 151.0 150.0 146.0 16:52:11 INFO - PROCESS | 21053 | 16:52:11 INFO - PROCESS | 21053 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 16:52:11 INFO - PROCESS | 21053 | Values: 96.0 97.0 95.0 96.0 95.0 96.0 96.0 97.0 97.0 95.0 16:52:11 INFO - PROCESS | 21053 | 16:52:11 INFO - PROCESS | 21053 | [#8] json-parse-financial Cycles:10 Average:66.70 Median:66.50 stddev:2.11 (3.2%) stddev-sans-first:1.05 16:52:11 INFO - PROCESS | 21053 | Values: 72.0 68.0 65.0 67.0 67.0 65.0 66.0 65.0 66.0 66.0 16:52:11 INFO - PROCESS | 21053 | 16:52:11 INFO - PROCESS | 21053 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 16:52:11 INFO - PROCESS | 21053 | Values: 66.0 67.0 66.0 66.0 67.0 69.0 67.0 66.0 66.0 67.0 16:52:11 INFO - PROCESS | 21053 | 16:52:11 INFO - PROCESS | 21053 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:85.00 stddev:3.63 (4.3%) stddev-sans-first:3.77 16:52:11 INFO - PROCESS | 21053 | Values: 84.0 84.0 84.0 84.0 85.0 84.0 86.0 85.0 95.0 90.0 16:52:11 INFO - PROCESS | 21053 | 16:52:11 INFO - PROCESS | 21053 | [#11] stanford-crypto-ccm Cycles:10 Average:149.70 Median:147.50 stddev:13.60 (9.2%) stddev-sans-first:14.40 16:52:11 INFO - PROCESS | 21053 | Values: 152.0 139.0 143.0 144.0 144.0 143.0 142.0 151.0 186.0 153.0 16:52:11 INFO - PROCESS | 21053 | 16:52:11 INFO - PROCESS | 21053 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.20 Median:176.50 stddev:3.43 (1.9%) stddev-sans-first:3.54 16:52:11 INFO - PROCESS | 21053 | Values: 175.0 184.0 175.0 177.0 183.0 175.0 176.0 177.0 175.0 175.0 16:52:11 INFO - PROCESS | 21053 | 16:52:11 INFO - PROCESS | 21053 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:72.00 stddev:2.66 (3.7%) stddev-sans-first:2.70 16:52:11 INFO - PROCESS | 21053 | Values: 70.0 70.0 71.0 72.0 72.0 71.0 69.0 76.0 77.0 74.0 16:52:11 INFO - PROCESS | 21053 | -------- Summary: end -------- 16:52:11 INFO - PROCESS | 21053 | 16:52:11 INFO - PROCESS | 21053 | [Parent 21053] WARNING: pipe error (77): Connection reset by peer: file /builds/slave/l-l64-000000000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 322 16:52:12 INFO - TEST-INFO | 21053: exit 0 16:52:13 INFO - TEST-OK | kraken | took 65520ms 16:52:13 INFO - SUITE-END | took 1185s 16:52:13 INFO - Completed test suite (00:19:45) 16:52:13 INFO - javascript benchmark 16:52:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6114.583205894789, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2565.461253136841, 2586.4309851832595, 2591.080166540878, 2597.0520759922633, 2636.2486691292975, 4494.25844735619, 4607.193741095303, 4658.604018658418, 4684.882877928049, 4714.858554243369, 4629.16674998501, 4632.5135860734645, 4693.953060469403, 4734.289856521524, 4747.715137091777, 4291.892702682435, 4319.935200971988, 4352.107817897323, 4374.03771170342, 4430.889227769316, 4327.826886924519, 4331.8700438986725, 4381.0, 4406.096750166224, 4421.0, 4221.409002739619, 4264.658827293809, 4292.12011537634, 4394.824207031715, 4416.381706561084, 4320.848770293024, 4340.804663790105, 4348.826046958118, 4402.625776808975, 4403.3174857897075, 4284.250256205151, 4311.892202694927, 4331.415258940035, 4358.368036634702, 4383.101464199864, 4543.477500087499, 4581.1753884300815, 4686.08621318843, 4717.882052948669, 4763.261694437368, 4954.058728841508, 4964.528369804862, 4969.701817890938, 4971.950280497221, 4975.427825800043, 4940.901181976376, 5004.3994720633755, 5087.26234695967, 5091.032703786269, 5178.223266510016, 4742.857714268577, 4750.762461876892, 4753.0, 4760.857174284777, 4809.78355973982, 5204.141316682781, 5221.530062294411, 5228.660137091077, 5232.529072383504, 5275.973620131952, 4838.080764654775, 4854.101991131652, 4912.508749125059, 4975.875603109879, 4977.402711674622, 4936.407631084293, 5039.798408063636, 5046.091703493406, 5049.040682270357, 5063.13926632466, 4954.355933728664, 5017.724025178651, 5026.271190677331, 5030.522100400456, 5036.874078148076, 4984.3021976923255, 4996.325496058058, 5008.474110218374, 5013.24801279811, 5065.924011139836, 3869.0, 3870.4000879863665, 3926.1362500249897, 3944.456820375756, 3996.1008773025837, 3421.298633780069, 3445.2248244144866, 3478.043538027063, 3486.1981744198974, 3491.4762785582366, 4311.051568654891, 4337.8264869404875, 4344.174606824693, 4347.152305300436, 4397.1205758848355, 4899.583535399531, 4942.827001055018, 4986.052649996562, 5013.548780609763, 5034.697918124924, 4355.1725172217175, 4384.714993525411, 4389.407429996973, 4411.338299255073, 4463.018136010072, 4502.977485112619, 4505.6846020778885, 4516.345129956138, 4518.593326600556, 4581.633469322446, 4654.837080702159, 4808.903821923612, 4813.422389313305, 4835.347228124158, 4878.341423907798, 4937.382827146606, 4948.554630083309, 4958.528939750718, 5017.172166592617, 5054.393472783143, 4710.8351207707565, 4711.363965864564, 4720.268358404453, 4725.29120631908, 4785.353977213032, 4758.04839032188, 4850.054239423279, 4906.484819093944, 4921.581665558468, 4981.0, 5051.888584511402, 5077.213031980049, 5092.490750924878, 5129.153689641167, 5148.58811295103, 4927.285543596086, 4927.334809800775, 4929.950700492949, 4960.305557222064, 5001.624878134227, 4812.446568644511, 4836.516348365135, 4868.634852386014, 4923.655344125877, 4957.752112394293, 4759.357486739246, 4817.325574419654, 4826.541478559531, 4854.126257273725, 4863.878403039811, 4895.534924182197, 4902.779374928208, 4918.827841025547, 4931.9753401232765, 4987.825426110068, 4768.189407800613, 4814.277858321279, 4814.831480898151, 4819.0, 4876.658633895735], "value": 4596.30137060726, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.7457220534146, 543.8912217556489, 544.5181014801899, 544.9019176548221, 553.3277068361939, 38370.808145959265, 40189.3971590426, 40248.0, 40251.39622905652, 40259.0, 41383.79308103455, 42032.0, 42044.846636502305, 42400.57599424005, 42405.57594424055, 7470.626468676558, 7532.284432978859, 7541.811454713621, 7548.886766698504, 7606.315431611154, 7684.615769211545, 7781.8832717509285, 7788.104367997667, 7790.5325680459355, 7796.6491507882, 7733.922660773376, 7773.0, 7831.295183433518, 7863.685452581918, 7874.724384646539, 7723.53658780475, 7739.380849532024, 7761.689532418753, 7763.301302882711, 7768.844623107534, 7652.426068044919, 7751.418643601753, 7765.883511747328, 7769.223077692242, 7772.455928085036, 38110.618893810984, 38412.23175536474, 38439.423408648894, 38640.22719545622, 38731.612683873085, 2881.884724611013, 2888.956665650017, 2916.7554813092715, 2928.677845437, 2958.511845545504, 27128.45743085147, 27997.440051199064, 28448.28879278014, 29021.274468138254, 29078.41843163146, 3298.4392653249006, 3330.1008727643643, 3355.0605830367535, 3368.1074515253476, 3378.7803792753393, 157656.0, 158947.0, 159019.0, 160898.0, 160960.19519902443, 54057.45942540524, 54303.99999999921, 54517.91267135247, 54641.1803822943, 54830.45169548333, 56800.307979982, 57171.0, 57240.713796431584, 57275.0, 57323.42676573181, 14026.509072182425, 14295.142291462545, 14311.499097531536, 14320.928395357956, 14382.568522944328, 10552.419616921143, 10727.249092563601, 10738.94630526858, 10766.461676916122, 10769.515371808287, 17014.829851701572, 17745.46763597094, 17816.46550603484, 17845.46463606094, 18082.649255596953, 6619.801405957829, 6645.833854153685, 6696.497762667819, 6734.050408094024, 6998.510104292753, 775.8525880082766, 918.9310801689767, 936.9344145909857, 943.1605870775015, 944.0465130218391, 27709.86145069302, 28175.71824281772, 28223.858880705466, 28596.571051434246, 28886.42227155487, 924.7532915158198, 963.1620490173594, 965.7199412170391, 1020.5254556631054, 1033.617561502249, 14625.488107916171, 15135.545933622008, 15195.316210770541, 15897.52307430779, 16500.33998640065, 388398.0, 391689.0, 392116.0, 392119.0, 393239.0, 50175.74912125416, 50630.24054639183, 50702.239466408035, 50766.74616626893, 50818.237726434134, 1155.589765633205, 1171.3264872698062, 1186.371223251678, 1187.679326581818, 1195.8266051422495, 27481.31296717598, 28781.0, 29322.387268700426, 29403.85298073496, 29453.85273073621, 41262.38106428346, 41598.37602435905, 41938.16123677448, 42043.1591368177, 42060.0, 314608.0, 318415.0, 318475.0, 318534.0, 318976.0, 25554.616680750176, 25603.615945760455, 25717.35706607275, 25755.871220643778, 25923.740762592886, 40634.390484143354, 41435.585644143175, 42047.0, 43338.78330608327, 45614.543854562355, 36253.818730906176, 36681.44977825388, 36719.0, 36892.26215475729, 37499.81250093732, 36427.63572364242, 36700.81649591735, 36820.63179368172, 37396.6260337404, 37518.06204844901, 35375.646243538264, 35789.0, 36163.0, 36294.8185259072, 36649.0, 31014.68985310208, 33244.83377583193, 33253.33493330071, 33394.666053339155, 33443.163920902174, 25471.872640636677, 25711.871440642677, 25792.355191119623, 25848.612270815578, 26069.608955865297], "value": 17316.365774381014, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.1560933517549, 359.489524874678, 361.5607037449498, 366.3021943198205, 376.1818045750494, 14817.851821481796, 15188.84811151888, 16376.263068161932, 16495.0, 16645.0, 11749.588764393227, 13876.861231387684, 15678.529644110666, 15704.214789260519, 16487.670246595062, 4934.925976110361, 5201.219817027457, 5210.140326846066, 5212.322398088262, 5217.37391513019, 4915.557599816016, 5068.239764035406, 5125.154349532323, 5139.203423469368, 5142.331496905397, 5093.26147708582, 5126.436092029874, 5130.538251557359, 5142.07442660321, 5144.22836574515, 4957.900841983176, 5109.616778741591, 5114.590832733373, 5117.948820511784, 5128.025675121715, 4565.178267911774, 4578.702384345007, 4609.539046095397, 4612.215923293048, 4617.676762626617, 19126.90436547822, 19569.21723131087, 19669.901650491654, 19703.80296197034, 19995.900020499805, 1694.3730819596706, 1832.844208242301, 1914.5213696575856, 1921.567647279365, 2287.2223444028946, 5097.439281679012, 5154.226865970097, 5189.792408303663, 9105.954470227607, 9296.116868897443, 1664.6837100950781, 1760.7622970898892, 1777.1558509707916, 1811.538057795267, 1822.7812662480587, 66635.0, 67580.0, 67857.66071169662, 68044.0, 68807.0, 8081.353491720648, 8536.914630853737, 8651.610677519528, 8737.956310218407, 9060.456372617664, 10765.3540787553, 10826.0, 10870.673879783619, 10883.129349652008, 10944.616938407118, 5981.192539007266, 6318.115463835067, 6685.765998190137, 6811.659417029129, 7078.150621925299, 6590.703418346186, 6843.623600702009, 6882.105326307548, 6896.551724137915, 7001.964990175016, 3740.8877733668032, 3765.9058523536582, 3834.405667121601, 3849.557300910375, 3902.6292502212245, 1614.1767698473627, 1660.4603503861051, 1725.3961113610137, 1763.8853474524115, 1851.3705340184133, 784.5880912520859, 814.3444527155578, 909.6270529083044, 938.216589148069, 952.9904700953041, 16014.839851601335, 16138.112403817902, 16374.83625163757, 16531.256093475822, 16947.830521694872, 817.8037271055023, 830.7258604660448, 832.4672209785742, 848.2789628815458, 849.592195746033, 8720.694775682821, 9515.619375225051, 9541.618335266512, 9580.760480987892, 9655.565499552536, 373853.0, 383278.0, 391804.0, 394288.0, 397518.0, 74762.0, 77826.0, 79061.41877162424, 79373.0, 79653.4155962983, 873.947563146226, 888.4846788862444, 908.8909330880336, 915.5102020419178, 915.9679411220575, 13938.721225575635, 14956.626084347543, 14974.176420296988, 15257.237138143271, 15297.46458873934, 37357.6264237365, 37646.24707505889, 37877.05307367338, 38184.0, 38456.807715961244, 46225.306620401396, 46730.29904551502, 47688.52311476841, 50163.74918125386, 50430.49569504258, 5071.54356107952, 5083.542481176712, 6988.336108069725, 7559.1306999695735, 7755.689772409266, 9975.703158589627, 10154.796904062025, 10361.4301213434, 11043.39261340634, 11098.778024439305, 8920.464772113693, 9162.816743664956, 9326.347155699035, 9340.439573625605, 9863.063009014133, 9527.809443810946, 9777.755556111155, 9945.104940555384, 9953.701388958343, 10047.09576138151, 9694.369865958972, 10064.597416103274, 10106.242031847494, 10373.740656483647, 10615.150787936793, 7471.663775130023, 7523.360514356122, 7604.923950760422, 7637.045369328834, 7763.68945242184, 8511.446755960842, 9490.28822838276, 9662.516874156123, 9702.812047350395, 10358.274920755475], "value": 7716.7080002080265, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1201.6335017819567, 1272.5238723081222, 1311.7704401729695, 1612.8306527814586, 1619.465576359802, 6340.524460665457, 6556.672166391673, 6950.478714096444, 7440.367568756656, 7461.477696561243, 6989.930100698992, 7310.744123955663, 7312.561246325211, 7496.962515187416, 7514.549127052367, 2069.772325044244, 2097.2449918029574, 2097.4336929029155, 2100.7584127825344, 2103.2323202031225, 2072.1504183284856, 2091.979080209201, 2097.800708932649, 2112.6830975353664, 2120.872747635147, 2056.897155142244, 2063.731714877071, 2064.07116797441, 2069.7412823397076, 2072.2332736887374, 1979.3863902190367, 1985.7418535590425, 1989.6717041688105, 1990.2138655231247, 1996.5208349996042, 1984.6130004649099, 1989.7711763147279, 2026.5744193719336, 2027.5843452092286, 2036.857419980587, 7012.929870701279, 7130.144382674061, 7176.3182497663165, 7201.783946481614, 7212.603306818123, 4248.702590818644, 4339.457567804025, 4366.432363792686, 4371.082072764723, 4375.2124617568825, 2754.394033312668, 2814.1979535832393, 2839.2475993861644, 2866.011226126983, 2873.726995935404, 867.9783005424852, 871.6295574380863, 885.198895000026, 885.716570697377, 897.1970086772368, 9774.16919561838, 9785.657501987396, 9840.901590984071, 9884.308098433112, 9898.752531186707, 3608.8376023079027, 3676.2647470506004, 3815.790131542736, 3830.6552410283207, 3843.1737176507186, 7704.537727736354, 7726.266004729542, 7730.458867879307, 7731.188225236382, 7731.458797884206, 4232.25935461293, 4247.0444150066605, 4247.214265360918, 4251.383549385322, 4254.361845723104, 3375.1224681582967, 3491.4064609016527, 3801.923961520754, 3905.5508616508896, 3922.5489068756888, 3153.0856051744736, 3201.791883527563, 3321.9501707474406, 3338.532605435241, 3341.2482191506715, 970.3498655900563, 994.3139233928566, 996.940183588987, 1003.3678782367062, 1003.934744241622, 749.2058418076856, 777.6850375597892, 783.3263393481601, 798.7683571764123, 801.2628381888676, 4687.67186296956, 4720.150372932836, 4820.325154478376, 4824.589909857631, 4969.90060198794, 398.38847369288004, 408.7792592000346, 414.1633899523007, 414.5833437395398, 416.69581205719993, 3173.984130079335, 3310.0731795097413, 3318.021183750799, 3327.8502467389026, 3344.782589131699, 8433.662653493915, 8607.22534971843, 8762.38663293576, 8881.200691937756, 8893.421927574687, 8672.219500245008, 8722.694705685271, 8726.86909696355, 8729.51987640686, 8760.912390876138, 6417.550771445954, 6825.9317406826285, 6886.793396198122, 6919.4464442844455, 6924.861502769916, 4695.248760198352, 4914.606831453547, 5012.974935125301, 5027.547520723152, 5168.793248270027, 7992.800179995546, 8122.837543248984, 8202.548859812528, 8278.71024514139, 8355.456895301786, 8058.194180581895, 8264.462809917337, 8285.62714677853, 8338.833223335621, 8373.0, 6115.755369785336, 6232.314445410911, 6334.524910631813, 6362.395572420613, 6378.840528986627, 7073.328033836778, 7147.499675022907, 7150.0, 7153.642317884189, 7177.031100801325, 6086.2087928569, 6131.754729810936, 6305.40098690642, 6357.268914074755, 6440.710168042356, 6259.812205633838, 6275.34108918557, 6278.434940855345, 6305.085762564494, 6312.274088479883, 5867.413258674099, 5874.619464425771, 5904.498117660047, 5910.970445147746, 5925.348211696796, 4124.237016151901, 4130.463039804806, 4216.873493795191, 4222.0, 4283.164782867311, 3979.144483935968, 4060.6548443382644, 4063.431119643193, 4084.571120032354, 4199.9370009450495], "value": 3749.923351738794, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.6820665474633, 293.2141859815693, 295.7545237452914, 299.492360449039, 307.1675758693939, 4895.804167833291, 4942.802287908484, 4966.453690094096, 4967.751612419378, 5004.5987123605355, 4879.414470263573, 4879.70721756694, 4891.926621100686, 4892.266160075981, 4909.656324057318, 3669.743117981742, 3747.812609369534, 3765.7740535567955, 3859.2281543691233, 3870.845166193349, 3812.7902965336893, 3819.828107735145, 3833.616638336158, 3834.980825095871, 3845.5193100862393, 3806.5622453417936, 3825.6227758007094, 3833.8658146964863, 3865.1303456722294, 3883.766973981556, 3791.658750712449, 3879.243547508237, 3885.338543097973, 3885.436611691317, 3886.727929044968, 3379.7803142795638, 3385.881494147693, 3393.573594879648, 3400.96599034009, 3421.367047096295, 4720.716756994557, 4769.332293478916, 4770.189067858472, 4779.545943135397, 4806.495317991596, 4378.0, 4393.231184542724, 4407.757573333465, 4410.933835992462, 4414.80133393998, 5090.872728181788, 5153.665011774223, 5169.302144210521, 5173.198154286091, 5183.067047931371, 3749.3063783199923, 3749.5875453700073, 3752.5309336332957, 3762.49206357141, 3764.5106136202394, 5347.598930080259, 5370.301860758115, 5447.673139611636, 5451.628541584463, 5477.4248703886315, 3705.1478160022807, 3770.245950809849, 3802.5056742623283, 3847.5382954045135, 3859.9421008684894, 3820.7707537547835, 3837.136644255076, 3837.808109594509, 3845.692344612424, 3856.1902000580194, 4269.188854117708, 4342.652587792969, 4355.891102722458, 4359.125576002286, 4376.387305777193, 4893.584045356185, 5115.335006449138, 5129.846104616868, 5134.589232861362, 5167.173252279692, 1334.3928512526777, 1363.9931800340935, 1364.979525307121, 1365.7268546290782, 1370.1984339161502, 857.9013413457408, 885.9246964008131, 886.1802832380023, 897.0625696147541, 902.3412908576776, 4066.9389959150635, 4073.8574149905203, 4378.978105109518, 4487.439070116236, 4541.318802179633, 5315.73421328932, 5331.226972089103, 5342.706151161646, 5347.81282655113, 5348.705821179872, 4598.471175814824, 4602.631789456836, 4603.792829322689, 4614.2617181250835, 4631.675782695246, 2801.6272026706765, 2841.1760589429246, 2843.957340639892, 2855.5436727269243, 2861.570764385359, 5064.7214403207445, 5080.441151473335, 5092.38891333035, 5094.465081166498, 5098.643094983389, 5439.857629897687, 5454.154606036071, 5470.316210473691, 5481.382287690106, 5497.780088796483, 4805.879853003633, 4972.254161875748, 5008.923081537487, 5015.423226329019, 5033.5721463676, 5274.868128296824, 5310.822562749254, 5323.866903327293, 5330.227117068081, 5334.199870019373, 4967.329410529676, 5162.277281180713, 5166.715830629351, 5176.534111929794, 5190.2214667800135, 4966.329545511309, 5005.449400566008, 5013.373328333958, 5015.2978582997675, 5019.67372120811, 3857.4213867920034, 3867.43922131295, 3867.555231148454, 3872.574016858087, 3883.572806991172, 5151.519668490205, 5384.838454846361, 5393.002294575516, 5401.783928642811, 5409.0, 5120.385553733576, 5150.201718733602, 5159.484051594811, 5159.767810448614, 5166.354205724285, 5081.415637201769, 5150.716710580954, 5155.200943853709, 5157.793688252428, 5171.767270472763, 4973.45292017885, 5052.269967719917, 5088.185890257541, 5105.310783044241, 5127.435982042047, 4898.730569818694, 5094.7962081516325, 5171.63798534099, 5177.249298851721, 5201.921971170511, 4943.752812359296, 4949.232868905326, 5090.211017292326, 5120.846374608767, 5121.359830021247], "value": 3896.4852874002963, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.5868328095567, 574.7787101965741, 582.3448620302161, 642.8874946884297, 664.4153145232196, 11502.597409090684, 12210.633680989562, 12250.632481025561, 12264.999999999989, 12450.875491245097, 11869.940650296758, 12093.758124837519, 12097.818532722016, 12107.576234831782, 12115.212511186766, 536.8792021795103, 722.9638518074102, 745.5340412242349, 750.7822731407886, 754.1591125894643, 552.6269767906667, 727.6434547071923, 740.3152084322007, 752.6989204318289, 755.4975940999229, 791.6160662078887, 792.5165648954134, 793.0245797668871, 794.1978601612356, 796.6136423834436, 779.286952438518, 782.6634547144726, 784.4116912315792, 785.35600807338, 787.7400457848896, 584.1208980484387, 584.433099893103, 584.8391692284613, 585.0843430031987, 586.9677167755772, 11873.94063029688, 11877.049836013099, 11886.167968242227, 11889.108316876269, 11949.581764638197, 12002.0, 12137.029037677054, 12408.0, 12458.75082498345, 12962.416691248916, 10016.649417270433, 10024.448655323955, 10078.244131690079, 10089.394636321844, 10170.338927969733, 3174.9206269843207, 3238.805671659708, 3254.479283314682, 3255.9348813023844, 3354.681305275995, 60268.39731602672, 60382.698086509285, 60554.69722651403, 61325.0, 61546.69226653883, 9776.169025632758, 9918.40489570628, 10036.749081273027, 10064.44645544502, 10287.794244115075, 17392.21735021927, 17421.303147874198, 17448.12759362027, 17502.299908003537, 17518.737218941726, 6246.531510136758, 6358.237011558643, 6370.0, 6444.484441244689, 6491.285958544557, 3165.9525107123413, 3229.935401291961, 3286.2277364819247, 3301.3562355340478, 3330.4338262495435, 2574.871256437171, 2726.7954903382324, 2753.7108603596735, 2756.8759405826786, 2757.310672331917, 467.0938379543674, 467.25706127257826, 474.3572459317644, 475.7240800335797, 479.38399157082983, 427.4763414816887, 476.9713817170981, 508.6846155383686, 521.3847659761442, 527.4751622135923, 7571.507851989603, 7598.734044308423, 7640.961795190989, 7704.5762483062845, 7884.448088633855, 468.2461237407771, 541.8401571536406, 556.2018503447484, 567.2398985359638, 575.9747649184459, 3371.7976921384798, 3556.0043187907427, 3601.505375269286, 3696.464012718141, 3802.448644946467, 50406.49593504018, 51423.22865157026, 74081.0, 84191.5790421044, 87726.56136719276, 45123.097538049056, 45781.31328030082, 46998.76500617475, 54585.0, 62207.6889615549, 42663.7866810664, 55245.723771380886, 68179.65910170418, 71414.64292678503, 71772.99999999895, 6983.3714965653335, 6999.0, 7124.501284910214, 7172.282771722786, 7310.561366318038, 40966.9758256046, 41695.7915210422, 41845.372319415845, 42190.789046054575, 42862.78568607137, 55502.72248638731, 55884.44115558793, 57619.423805761406, 61201.0, 61276.0, 9183.173514383738, 9587.808243835223, 9709.320347575602, 9945.801083978424, 10019.649312274036, 10089.041541053588, 10161.479333426, 10208.556574195294, 10261.639822840938, 10442.582296708351, 9234.584443700183, 9380.57787399555, 9408.43549387039, 9418.481983490974, 9491.715248542554, 9332.160105590257, 9361.157495825408, 9496.43021418717, 9521.714348569554, 9580.329376943826, 9018.0, 9126.954365228132, 9175.357724959189, 9176.724698259062, 9196.816063678823, 8241.50550966944, 8375.664973400995, 8466.195711407407, 8484.91515084866, 8599.484030958163, 7893.526388416713, 7896.447248692536, 8175.509469431853, 8500.0, 9028.909710902806], "value": 5823.135288426726, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1578.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 114.0, 114.0, 114.0, 115.0, 115.0, 115.0, 115.0, 116.0, 116.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 130.0, 134.0, 171.0, 134.0, 128.0, 132.0, 127.0, 169.0, 129.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 163.0, 161.0, 164.0, 164.0, 163.0, 165.0, 163.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 116.0, 77.0, 76.0, 77.0, 78.0, 103.0, 78.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 119.0, 84.0, 84.0, 85.0, 104.0, 85.0, 83.0, 118.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 119.0, 119.0, 118.0, 118.0, 118.0, 120.0, 117.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 150.0, 152.0, 151.0, 150.0, 153.0, 151.0, 150.0, 146.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 96.0, 95.0, 96.0, 96.0, 97.0, 97.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 65.0, 67.0, 67.0, 65.0, 66.0, 65.0, 66.0, 66.0], "value": 66.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 67.0, 69.0, 67.0, 66.0, 66.0, 67.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 86.0, 85.0, 95.0, 90.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 139.0, 143.0, 144.0, 144.0, 143.0, 142.0, 151.0, 186.0, 153.0], "value": 149.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 184.0, 175.0, 177.0, 183.0, 175.0, 176.0, 177.0, 175.0, 175.0], "value": 177.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 71.0, 72.0, 72.0, 71.0, 69.0, 76.0, 77.0, 74.0], "value": 72.2, "unit": "score"}]}]} 16:52:13 INFO - Return code: 0 16:52:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:52:13 ERROR - # TBPL SUCCESS # 16:52:13 INFO - Running post-action listener: _resource_record_post_action 16:52:13 INFO - [mozharness: 2016-10-11 23:52:13.547250Z] Finished run-tests step (success) 16:52:13 INFO - Running post-run listener: _resource_record_post_run 16:52:13 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392376320; Read time: 16; Write time: 253800 16:52:13 INFO - TinderboxPrint: CPU usage
13.4% 16:52:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:52:13 INFO - TinderboxPrint: I/O write bytes / time
392,376,320 / 253,800 16:52:13 INFO - TinderboxPrint: CPU idle
8,299.9 (86.6%) 16:52:13 INFO - TinderboxPrint: CPU user
1,224.5 (12.8%) 16:52:13 INFO - TinderboxPrint: Swap in / out
0 / 0 16:52:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100134912; Read time: 0; Write time: 74320 16:52:13 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 292241408; Read time: 0; Write time: 179480 16:52:14 INFO - Running post-run listener: _upload_blobber_files 16:52:14 INFO - Blob upload gear active. 16:52:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:52:14 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 16:52:14 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', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:52:14 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 Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:52:14 INFO - (blobuploader) - INFO - Open directory for files ... 16:52:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:52:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:52:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:15 INFO - (blobuploader) - INFO - Done attempting. 16:52:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:52:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:52:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:18 INFO - (blobuploader) - INFO - Done attempting. 16:52:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:52:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:52:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:19 INFO - (blobuploader) - INFO - Done attempting. 16:52:19 INFO - (blobuploader) - INFO - Iteration through files over. 16:52:19 INFO - Return code: 0 16:52:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:52:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:52:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/5ad6ea43d40b59fc53c2d3bbaeb0192c4a73604bc4fcbe185c1b4d983687962f4c350ab444d907004e60dcac67b103dc3b7d9da6a268ec981b5a87971d784cbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/4d5a02d1167e2c291091060649dea9049b987fd0103c7829cd12fd295d75f9f789a840378ec9715f9c6eb1a66100c35917367a55ed9f95f04ee2eaade0c3bc38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/cef866aee3f2c1e35e15cb2d18a125a29af88c14cd93d7a76455e60cdfb256f2197d09451d7d990968db659d96752740ff9b3845303e68b6c08229c7e100e083"} 16:52:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:52:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:52:19 INFO - Contents: 16:52:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/5ad6ea43d40b59fc53c2d3bbaeb0192c4a73604bc4fcbe185c1b4d983687962f4c350ab444d907004e60dcac67b103dc3b7d9da6a268ec981b5a87971d784cbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/4d5a02d1167e2c291091060649dea9049b987fd0103c7829cd12fd295d75f9f789a840378ec9715f9c6eb1a66100c35917367a55ed9f95f04ee2eaade0c3bc38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/cef866aee3f2c1e35e15cb2d18a125a29af88c14cd93d7a76455e60cdfb256f2197d09451d7d990968db659d96752740ff9b3845303e68b6c08229c7e100e083"} 16:52:19 INFO - Running post-run listener: copy_logs_to_upload_dir 16:52:19 INFO - Copying logs to upload dir... 16:52:19 INFO - mkdir: /builds/slave/test/build/upload/logs 16:52:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.707030 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-11 16:52:19.079330) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 16:52:19.083195) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165 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/Larch-Non-PGO/sha512/5ad6ea43d40b59fc53c2d3bbaeb0192c4a73604bc4fcbe185c1b4d983687962f4c350ab444d907004e60dcac67b103dc3b7d9da6a268ec981b5a87971d784cbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/4d5a02d1167e2c291091060649dea9049b987fd0103c7829cd12fd295d75f9f789a840378ec9715f9c6eb1a66100c35917367a55ed9f95f04ee2eaade0c3bc38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/cef866aee3f2c1e35e15cb2d18a125a29af88c14cd93d7a76455e60cdfb256f2197d09451d7d990968db659d96752740ff9b3845303e68b6c08229c7e100e083"} build_url:https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/YguhHpTmRrWlrsN8U7aVWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/5ad6ea43d40b59fc53c2d3bbaeb0192c4a73604bc4fcbe185c1b4d983687962f4c350ab444d907004e60dcac67b103dc3b7d9da6a268ec981b5a87971d784cbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/4d5a02d1167e2c291091060649dea9049b987fd0103c7829cd12fd295d75f9f789a840378ec9715f9c6eb1a66100c35917367a55ed9f95f04ee2eaade0c3bc38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/cef866aee3f2c1e35e15cb2d18a125a29af88c14cd93d7a76455e60cdfb256f2197d09451d7d990968db659d96752740ff9b3845303e68b6c08229c7e100e083"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 16:52:19.109938) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 16:52:19.110309) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1476228692.418116-1838614165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 16:52:19.193999) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 16:52:19.194349) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 16:52:19.194696) ========= ========= Total master_lag: 0.18 =========