builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1476917897.57 results: success (0) buildid: 20161019123223 builduid: 9747542a92e4426aa24bf8f27dd7a140 revision: babb18c5b2a7af9f9fe5c1c8e88d580f48d3a001 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 15:58:17.566597) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 15:58:17.567153) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 15:58:17.567477) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 15:58:17.582381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:58:17.582841) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-19 15:58:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-10-19 15:58:18 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.072525 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:58:17.671310) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:58:17.671666) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020149 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:58:17.722258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:58:17.722661) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev babb18c5b2a7af9f9fe5c1c8e88d580f48d3a001 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev babb18c5b2a7af9f9fe5c1c8e88d580f48d3a001 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-19 15:58:18,230 truncating revision to first 12 chars 2016-10-19 15:58:18,230 Setting DEBUG logging. 2016-10-19 15:58:18,230 attempt 1/10 2016-10-19 15:58:18,230 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/babb18c5b2a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 15:58:18,600 unpacking tar archive at: autoland-babb18c5b2a7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.693386 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:58:18.434080) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 15:58:18.434914) ========= script_repo_revision: babb18c5b2a7af9f9fe5c1c8e88d580f48d3a001 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 15:58:18.435905) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 15:58:18.436575) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 15:58:18.448298) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-19 15:58:18.448609) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:58:19 INFO - MultiFileLogger online at 20161019 15:58:19 in /builds/slave/test 15:58:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 15:58:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:58:19 INFO - {'append_to_log': False, 15:58:19 INFO - 'base_work_dir': '/builds/slave/test', 15:58:19 INFO - 'blob_upload_branch': 'Autoland', 15:58:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:58:19 INFO - 'branch': 'Autoland', 15:58:19 INFO - 'buildbot_json_path': 'buildprops.json', 15:58:19 INFO - 'config_files': ('talos/linux_config.py',), 15:58:19 INFO - 'default_actions': ('clobber', 15:58:19 INFO - 'read-buildbot-config', 15:58:19 INFO - 'download-and-extract', 15:58:19 INFO - 'populate-webroot', 15:58:19 INFO - 'create-virtualenv', 15:58:19 INFO - 'install', 15:58:19 INFO - 'run-tests'), 15:58:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:58:19 INFO - 'download_minidump_stackwalk': True, 15:58:19 INFO - 'download_symbols': 'ondemand', 15:58:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:58:19 INFO - 'tooltool.py': '/tools/tooltool.py', 15:58:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:58:19 INFO - '/tools/misc-python/virtualenv.py')}, 15:58:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:58:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:58:19 INFO - 'installer_path': 'installer.exe', 15:58:19 INFO - 'log_level': 'info', 15:58:19 INFO - 'log_name': 'talos', 15:58:19 INFO - 'log_to_console': True, 15:58:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:58:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:58:19 INFO - 'opt_config_files': (), 15:58:19 INFO - 'pip_index': False, 15:58:19 INFO - 'sps_profile': False, 15:58:19 INFO - 'sps_profile_interval': 0, 15:58:19 INFO - 'suite': 'dromaeojs-e10s', 15:58:19 INFO - 'system_bits': '32', 15:58:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:58:19 INFO - 'title': 'talos-linux64-ix-041', 15:58:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:58:19 INFO - 'use_talos_json': True, 15:58:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:58:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:58:19 INFO - 'work_dir': 'build'} 15:58:19 INFO - [mozharness: 2016-10-19 22:58:19.053144Z] Running clobber step. 15:58:19 INFO - Running pre-action listener: _resource_record_pre_action 15:58:19 INFO - Running main action method: clobber 15:58:19 INFO - rmtree: /builds/slave/test/build 15:58:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:58:19 INFO - Running post-action listener: _resource_record_post_action 15:58:19 INFO - [mozharness: 2016-10-19 22:58:19.530929Z] Finished clobber step (success) 15:58:19 INFO - [mozharness: 2016-10-19 22:58:19.531028Z] Running read-buildbot-config step. 15:58:19 INFO - Running pre-action listener: _resource_record_pre_action 15:58:19 INFO - Running main action method: read_buildbot_config 15:58:19 INFO - Using buildbot properties: 15:58:19 INFO - { 15:58:19 INFO - "project": "", 15:58:19 INFO - "product": "firefox", 15:58:19 INFO - "script_repo_revision": "production", 15:58:19 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 15:58:19 INFO - "repository": "", 15:58:19 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 15:58:19 INFO - "buildid": "20161019123223", 15:58:19 INFO - "pgo_build": "True", 15:58:19 INFO - "basedir": "/builds/slave/test", 15:58:19 INFO - "buildnumber": 355, 15:58:19 INFO - "slavename": "talos-linux64-ix-041", 15:58:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:58:19 INFO - "platform": "ubuntu64_hw", 15:58:19 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 15:58:19 INFO - "branch": "autoland", 15:58:19 INFO - "repo_path": "integration/autoland", 15:58:19 INFO - "revision": "babb18c5b2a7af9f9fe5c1c8e88d580f48d3a001", 15:58:19 INFO - "stage_platform": "linux64-pgo", 15:58:19 INFO - "builduid": "9747542a92e4426aa24bf8f27dd7a140", 15:58:19 INFO - "slavebuilddir": "test" 15:58:19 INFO - } 15:58:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:58:19 INFO - Running post-action listener: _resource_record_post_action 15:58:19 INFO - [mozharness: 2016-10-19 22:58:19.533457Z] Finished read-buildbot-config step (success) 15:58:19 INFO - [mozharness: 2016-10-19 22:58:19.533547Z] Running download-and-extract step. 15:58:19 INFO - Running pre-action listener: _resource_record_pre_action 15:58:19 INFO - Running main action method: download_and_extract 15:58:19 INFO - mkdir: /builds/slave/test/build/tests 15:58:19 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')]} 15:58:19 INFO - trying https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:58:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/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 15:58:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/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 15:58:20 INFO - Downloaded 1361 bytes. 15:58:20 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:58:20 INFO - Using the following test package requirements: 15:58:20 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:58:20 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:58:20 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:58:20 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:20 INFO - u'jsshell-linux-x86_64.zip'], 15:58:20 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:58:20 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:58:20 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:58:20 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:58:20 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:58:20 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:58:20 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:58:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:58:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:58:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:58:20 INFO - Http code: 200 15:58:20 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 15:58:20 INFO - x-amz-cf-id: wNJI1UuskCKsWjqpkq0MerrHFOwJLsJUJvBZK8RE-Uxyao90oWs8Pw== 15:58:20 INFO - x-amz-version-id: W3eTZUY4CKkddh7ZTpE06HgRtjTaRvXQ 15:58:21 INFO - Expected file size: 22110913 15:58:21 INFO - Obtained file size: 22110913 15:58:25 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 15:58:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:58:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:58:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:58:25 INFO - Http code: 200 15:58:25 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 15:58:25 INFO - x-amz-cf-id: ttnwyCvkaLQqrjtf5KFV3bt-jmu_tIkrm6we3dCbjYlk0NFSR0vMrA== 15:58:25 INFO - x-amz-version-id: W3eTZUY4CKkddh7ZTpE06HgRtjTaRvXQ 15:58:25 INFO - Expected file size: 22110913 15:58:25 INFO - Obtained file size: 22110913 15:58:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:58:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:58:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:58:31 INFO - Http code: 200 15:58:31 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 15:58:31 INFO - x-amz-cf-id: 8beo2kUWd9R0G-FwGYyc3WY_5IeiY-BvUMSAooLfo2Wm7qVTuduang== 15:58:31 INFO - x-amz-version-id: A_yF9_iKwd.lOAqphojuMdmPic3kx.3i 15:58:31 INFO - Expected file size: 14409028 15:58:31 INFO - Obtained file size: 14409028 15:58:31 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')]} 15:58:31 INFO - trying https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:58:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/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 15:58:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/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 15:58:32 INFO - Downloaded 59463559 bytes. 15:58:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:58:32 INFO - mkdir: /builds/slave/test/properties 15:58:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:58:32 INFO - Writing to file /builds/slave/test/properties/build_url 15:58:32 INFO - Contents: 15:58:32 INFO - build_url:https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:58:33 INFO - Running post-action listener: _resource_record_post_action 15:58:33 INFO - Running post-action listener: set_extra_try_arguments 15:58:33 INFO - [mozharness: 2016-10-19 22:58:33.303405Z] Finished download-and-extract step (success) 15:58:33 INFO - [mozharness: 2016-10-19 22:58:33.303629Z] Running populate-webroot step. 15:58:33 INFO - Running pre-action listener: _resource_record_pre_action 15:58:33 INFO - Running main action method: populate_webroot 15:58:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:58:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:58:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:58:33 INFO - '--tppagecycles', 15:58:33 INFO - '7'], 15:58:33 INFO - 'tests': ['tsvgm']}}, 15:58:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:58:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:58:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:58:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:58:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:58:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:58:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:33 INFO - 'talos_options': ['--disable-e10s'], 15:58:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:33 INFO - 'talos_options': ['--disable-e10s'], 15:58:33 INFO - 'tests': ['damp', 'tps']}, 15:58:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:33 INFO - 'tests': ['damp', 'tps']}, 15:58:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:58:33 INFO - 'tests': ['dromaeo_dom']}, 15:58:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:58:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:58:33 INFO - 'tests': ['basic_compositor_video']}, 15:58:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:58:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:58:33 INFO - 'tests': ['a11yr', 15:58:33 INFO - 'ts_paint', 15:58:33 INFO - 'tpaint', 15:58:33 INFO - 'sessionrestore', 15:58:33 INFO - 'sessionrestore_no_auto_restore', 15:58:33 INFO - 'tabpaint']}, 15:58:33 INFO - 'other-e10s': {'tests': ['a11yr', 15:58:33 INFO - 'ts_paint', 15:58:33 INFO - 'tpaint', 15:58:33 INFO - 'sessionrestore', 15:58:33 INFO - 'sessionrestore_no_auto_restore', 15:58:33 INFO - 'tabpaint']}, 15:58:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:58:33 INFO - 'ts_paint', 15:58:33 INFO - 'tpaint', 15:58:33 INFO - 'sessionrestore', 15:58:33 INFO - 'sessionrestore_no_auto_restore', 15:58:33 INFO - 'tabpaint']}, 15:58:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:58:33 INFO - 'ts_paint', 15:58:33 INFO - 'tpaint', 15:58:33 INFO - 'sessionrestore', 15:58:33 INFO - 'sessionrestore_no_auto_restore', 15:58:33 INFO - 'tabpaint']}, 15:58:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:58:33 INFO - 'tests': ['a11yr', 15:58:33 INFO - 'ts_paint', 15:58:33 INFO - 'tpaint', 15:58:33 INFO - 'sessionrestore', 15:58:33 INFO - 'sessionrestore_no_auto_restore', 15:58:33 INFO - 'tabpaint']}, 15:58:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:58:33 INFO - 'tests': ['a11yr', 15:58:33 INFO - 'ts_paint', 15:58:33 INFO - 'tpaint', 15:58:33 INFO - 'sessionrestore', 15:58:33 INFO - 'sessionrestore_no_auto_restore', 15:58:33 INFO - 'tabpaint']}, 15:58:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:58:33 INFO - 'tests': ['tsvgx', 15:58:33 INFO - 'tsvgr_opacity', 15:58:33 INFO - 'tart', 15:58:33 INFO - 'tscrollx', 15:58:33 INFO - 'cart']}, 15:58:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:58:33 INFO - 'tsvgr_opacity', 15:58:33 INFO - 'tart', 15:58:33 INFO - 'tscrollx', 15:58:33 INFO - 'cart']}, 15:58:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:33 INFO - 'talos_options': ['--disable-e10s'], 15:58:33 INFO - 'tests': ['tp5o']}, 15:58:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:33 INFO - 'tests': ['tp5o']}, 15:58:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:33 INFO - 'talos_options': ['--disable-e10s', 15:58:33 INFO - '--xperf_path', 15:58:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:33 INFO - 'tests': ['tp5n']}, 15:58:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:33 INFO - 'talos_options': ['--xperf_path', 15:58:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:33 INFO - 'tests': ['tp5n']}}, 15:58:33 INFO - 'talos.zip': {'path': '', 15:58:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:58:33 INFO - Running post-action listener: _resource_record_post_action 15:58:33 INFO - [mozharness: 2016-10-19 22:58:33.320583Z] Finished populate-webroot step (success) 15:58:33 INFO - [mozharness: 2016-10-19 22:58:33.320671Z] Running create-virtualenv step. 15:58:33 INFO - Running pre-action listener: _resource_record_pre_action 15:58:33 INFO - Running main action method: create_virtualenv 15:58:33 INFO - Creating virtualenv /builds/slave/test/build/venv 15:58:33 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 15:58:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:58:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:58:33 INFO - Using real prefix '/usr' 15:58:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:58:33 INFO - Installing distribute.............................................................................................................................................................................................done. 15:58:35 INFO - Installing pip.................done. 15:58:35 INFO - Return code: 0 15:58:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:58:36 INFO - Reading from file tmpfile_stdout 15:58:36 INFO - Output received: 15:58:36 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) 15:58:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:58:36 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')]} 15:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:36 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')]} 15:58:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:36 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 0x7f93768e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c0790>, '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 0x19c1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b20>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', '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 15:58:36 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 15:58:36 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 15:58:36 INFO - Using env: {'DISPLAY': ':0', 15:58:36 INFO - 'HOME': '/home/cltbld', 15:58:36 INFO - 'LANG': 'en_US.UTF-8', 15:58:36 INFO - 'LANGUAGE': 'en_US:en', 15:58:36 INFO - 'LOGNAME': 'cltbld', 15:58:36 INFO - 'MAIL': '/var/mail/cltbld', 15:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:36 INFO - 'MOZ_NO_REMOTE': '1', 15:58:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:36 INFO - 'NO_EM_RESTART': '1', 15:58:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:36 INFO - 'PWD': '/builds/slave/test', 15:58:36 INFO - 'SHELL': '/bin/bash', 15:58:36 INFO - 'SHLVL': '1', 15:58:36 INFO - 'TERM': 'linux', 15:58:36 INFO - 'TMOUT': '86400', 15:58:36 INFO - 'USER': 'cltbld', 15:58:36 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', 15:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:36 INFO - '_': '/tools/buildbot/bin/python'} 15:58:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:36 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 15:58:36 INFO - Cleaning up... 15:58:36 INFO - Return code: 0 15:58:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:58:36 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')]} 15:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:36 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')]} 15:58:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:36 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 0x7f93768e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c0790>, '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 0x19c1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b20>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', '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 15:58:36 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 15:58:36 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 15:58:36 INFO - Using env: {'DISPLAY': ':0', 15:58:36 INFO - 'HOME': '/home/cltbld', 15:58:36 INFO - 'LANG': 'en_US.UTF-8', 15:58:36 INFO - 'LANGUAGE': 'en_US:en', 15:58:36 INFO - 'LOGNAME': 'cltbld', 15:58:36 INFO - 'MAIL': '/var/mail/cltbld', 15:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:36 INFO - 'MOZ_NO_REMOTE': '1', 15:58:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:36 INFO - 'NO_EM_RESTART': '1', 15:58:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:36 INFO - 'PWD': '/builds/slave/test', 15:58:36 INFO - 'SHELL': '/bin/bash', 15:58:36 INFO - 'SHLVL': '1', 15:58:36 INFO - 'TERM': 'linux', 15:58:36 INFO - 'TMOUT': '86400', 15:58:36 INFO - 'USER': 'cltbld', 15:58:36 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', 15:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:36 INFO - '_': '/tools/buildbot/bin/python'} 15:58:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:36 INFO - Downloading/unpacking psutil>=3.1.1 15:58:36 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 15:58:36 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 15:58:36 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 15:58:36 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 15:58:36 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 15:58:36 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 15:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:58:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:39 INFO - Installing collected packages: psutil 15:58:39 INFO - Running setup.py install for psutil 15:58:39 INFO - building 'psutil._psutil_linux' extension 15:58:39 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 15:58:39 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 15:58:39 INFO - building 'psutil._psutil_posix' extension 15:58:39 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 15:58:39 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 15:58:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:40 INFO - Successfully installed psutil 15:58:40 INFO - Cleaning up... 15:58:40 INFO - Return code: 0 15:58:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:58:40 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')]} 15:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:40 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')]} 15:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:40 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 0x7f93768e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c0790>, '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 0x19c1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b20>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', '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 15:58:40 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 15:58:40 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 15:58:40 INFO - Using env: {'DISPLAY': ':0', 15:58:40 INFO - 'HOME': '/home/cltbld', 15:58:40 INFO - 'LANG': 'en_US.UTF-8', 15:58:40 INFO - 'LANGUAGE': 'en_US:en', 15:58:40 INFO - 'LOGNAME': 'cltbld', 15:58:40 INFO - 'MAIL': '/var/mail/cltbld', 15:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:40 INFO - 'MOZ_NO_REMOTE': '1', 15:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:40 INFO - 'NO_EM_RESTART': '1', 15:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:40 INFO - 'PWD': '/builds/slave/test', 15:58:40 INFO - 'SHELL': '/bin/bash', 15:58:40 INFO - 'SHLVL': '1', 15:58:40 INFO - 'TERM': 'linux', 15:58:40 INFO - 'TMOUT': '86400', 15:58:40 INFO - 'USER': 'cltbld', 15:58:40 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', 15:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:40 INFO - '_': '/tools/buildbot/bin/python'} 15:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:58:40 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 15:58:40 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 15:58:40 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 15:58:40 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 15:58:40 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 15:58:40 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 15:58:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:58:42 INFO - Installing collected packages: mozsystemmonitor 15:58:42 INFO - Running setup.py install for mozsystemmonitor 15:58:42 INFO - Successfully installed mozsystemmonitor 15:58:42 INFO - Cleaning up... 15:58:42 INFO - Return code: 0 15:58:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:58:42 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')]} 15:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:42 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')]} 15:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:42 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 0x7f93768e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c0790>, '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 0x19c1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b20>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', '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 15:58:42 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 15:58:42 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 15:58:42 INFO - Using env: {'DISPLAY': ':0', 15:58:42 INFO - 'HOME': '/home/cltbld', 15:58:42 INFO - 'LANG': 'en_US.UTF-8', 15:58:42 INFO - 'LANGUAGE': 'en_US:en', 15:58:42 INFO - 'LOGNAME': 'cltbld', 15:58:42 INFO - 'MAIL': '/var/mail/cltbld', 15:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:42 INFO - 'MOZ_NO_REMOTE': '1', 15:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:42 INFO - 'NO_EM_RESTART': '1', 15:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:42 INFO - 'PWD': '/builds/slave/test', 15:58:42 INFO - 'SHELL': '/bin/bash', 15:58:42 INFO - 'SHLVL': '1', 15:58:42 INFO - 'TERM': 'linux', 15:58:42 INFO - 'TMOUT': '86400', 15:58:42 INFO - 'USER': 'cltbld', 15:58:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', 15:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:42 INFO - '_': '/tools/buildbot/bin/python'} 15:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:42 INFO - Downloading/unpacking jsonschema==2.5.1 15:58:42 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 15:58:42 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 15:58:42 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 15:58:42 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 15:58:42 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 15:58:42 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 15:58:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:58:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:58:44 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 15:58:44 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 15:58:44 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 15:58:44 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 15:58:44 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 15:58:44 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 15:58:44 INFO - Downloading functools32-3.2.3-2.tar.gz 15:58:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:58:44 INFO - warning: no files found matching '*.txt' 15:58:44 INFO - no previously-included directories found matching 'build' 15:58:44 INFO - no previously-included directories found matching 'dist' 15:58:44 INFO - no previously-included directories found matching '.git*' 15:58:44 INFO - Installing collected packages: jsonschema, functools32 15:58:44 INFO - Running setup.py install for functools32 15:58:45 INFO - warning: no files found matching '*.txt' 15:58:45 INFO - no previously-included directories found matching 'build' 15:58:45 INFO - no previously-included directories found matching 'dist' 15:58:45 INFO - no previously-included directories found matching '.git*' 15:58:45 INFO - Successfully installed jsonschema functools32 15:58:45 INFO - Cleaning up... 15:58:45 INFO - Return code: 0 15:58:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:45 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 0x7f93768e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c0790>, '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 0x19c1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b20>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', '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 15:58:45 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 15:58:45 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 15:58:45 INFO - Using env: {'DISPLAY': ':0', 15:58:45 INFO - 'HOME': '/home/cltbld', 15:58:45 INFO - 'LANG': 'en_US.UTF-8', 15:58:45 INFO - 'LANGUAGE': 'en_US:en', 15:58:45 INFO - 'LOGNAME': 'cltbld', 15:58:45 INFO - 'MAIL': '/var/mail/cltbld', 15:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:45 INFO - 'MOZ_NO_REMOTE': '1', 15:58:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:45 INFO - 'NO_EM_RESTART': '1', 15:58:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:45 INFO - 'PWD': '/builds/slave/test', 15:58:45 INFO - 'SHELL': '/bin/bash', 15:58:45 INFO - 'SHLVL': '1', 15:58:45 INFO - 'TERM': 'linux', 15:58:45 INFO - 'TMOUT': '86400', 15:58:45 INFO - 'USER': 'cltbld', 15:58:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', 15:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:45 INFO - '_': '/tools/buildbot/bin/python'} 15:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:58:45 INFO - Cleaning up... 15:58:45 INFO - Return code: 0 15:58:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:45 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 0x7f93768e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c0790>, '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 0x19c1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b20>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', '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 15:58:45 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 15:58:45 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 15:58:45 INFO - Using env: {'DISPLAY': ':0', 15:58:45 INFO - 'HOME': '/home/cltbld', 15:58:45 INFO - 'LANG': 'en_US.UTF-8', 15:58:45 INFO - 'LANGUAGE': 'en_US:en', 15:58:45 INFO - 'LOGNAME': 'cltbld', 15:58:45 INFO - 'MAIL': '/var/mail/cltbld', 15:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:45 INFO - 'MOZ_NO_REMOTE': '1', 15:58:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:45 INFO - 'NO_EM_RESTART': '1', 15:58:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:45 INFO - 'PWD': '/builds/slave/test', 15:58:45 INFO - 'SHELL': '/bin/bash', 15:58:45 INFO - 'SHLVL': '1', 15:58:45 INFO - 'TERM': 'linux', 15:58:45 INFO - 'TMOUT': '86400', 15:58:45 INFO - 'USER': 'cltbld', 15:58:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', 15:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:45 INFO - '_': '/tools/buildbot/bin/python'} 15:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:45 INFO - Downloading/unpacking blobuploader==1.2.4 15:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:47 INFO - Downloading blobuploader-1.2.4.tar.gz 15:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:58:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:58:47 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 15:58:47 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 15:58:47 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 15:58:47 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 15:58:47 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 15:58:47 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 15:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:58:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:58:47 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 15:58:47 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 15:58:47 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 15:58:47 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 15:58:47 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 15:58:47 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 15:58:48 INFO - Downloading docopt-0.6.1.tar.gz 15:58:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:58:48 INFO - Installing collected packages: blobuploader, requests, docopt 15:58:48 INFO - Running setup.py install for blobuploader 15:58:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:58:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:58:48 INFO - Running setup.py install for requests 15:58:48 INFO - Running setup.py install for docopt 15:58:48 INFO - Successfully installed blobuploader requests docopt 15:58:48 INFO - Cleaning up... 15:58:48 INFO - Return code: 0 15:58:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:48 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 0x7f93768e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c0790>, '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 0x19c1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b20>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', '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 15:58:48 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 15:58:48 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 15:58:48 INFO - Using env: {'DISPLAY': ':0', 15:58:48 INFO - 'HOME': '/home/cltbld', 15:58:48 INFO - 'LANG': 'en_US.UTF-8', 15:58:48 INFO - 'LANGUAGE': 'en_US:en', 15:58:48 INFO - 'LOGNAME': 'cltbld', 15:58:48 INFO - 'MAIL': '/var/mail/cltbld', 15:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:48 INFO - 'MOZ_NO_REMOTE': '1', 15:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:48 INFO - 'NO_EM_RESTART': '1', 15:58:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:48 INFO - 'PWD': '/builds/slave/test', 15:58:48 INFO - 'SHELL': '/bin/bash', 15:58:48 INFO - 'SHLVL': '1', 15:58:48 INFO - 'TERM': 'linux', 15:58:48 INFO - 'TMOUT': '86400', 15:58:48 INFO - 'USER': 'cltbld', 15:58:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', 15:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:48 INFO - '_': '/tools/buildbot/bin/python'} 15:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:58:49 INFO - Running setup.py (path:/tmp/pip-lJLOX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:58:49 INFO - Running setup.py (path:/tmp/pip-rJYwIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:58:49 INFO - Running setup.py (path:/tmp/pip-FggpRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:58:49 INFO - Running setup.py (path:/tmp/pip-GZgYlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:58:49 INFO - Running setup.py (path:/tmp/pip-f1pKQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:58:49 INFO - Running setup.py (path:/tmp/pip-udxNAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:58:49 INFO - Running setup.py (path:/tmp/pip-CVs1gD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:58:49 INFO - Running setup.py (path:/tmp/pip-qJIwB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:58:49 INFO - Running setup.py (path:/tmp/pip-eRrLAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:58:49 INFO - Running setup.py (path:/tmp/pip-Dap57K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:58:49 INFO - Running setup.py (path:/tmp/pip-jE0Ngz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:58:49 INFO - Running setup.py (path:/tmp/pip-3T0HlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:58:49 INFO - Running setup.py (path:/tmp/pip-ICp8Yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:58:50 INFO - Running setup.py (path:/tmp/pip-Dw7SfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:58:50 INFO - Running setup.py (path:/tmp/pip-c4PqUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:58:50 INFO - Running setup.py (path:/tmp/pip-SSBUAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:58:50 INFO - Running setup.py (path:/tmp/pip-mzjZ6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:58:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:58:50 INFO - Running setup.py install for manifestparser 15:58:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:58:50 INFO - Running setup.py install for mozcrash 15:58:50 INFO - Running setup.py install for mozdebug 15:58:50 INFO - Running setup.py install for mozdevice 15:58:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:58:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:58:50 INFO - Running setup.py install for mozfile 15:58:50 INFO - Running setup.py install for mozhttpd 15:58:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:58:50 INFO - Running setup.py install for mozinfo 15:58:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:58:51 INFO - Running setup.py install for mozInstall 15:58:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:58:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:58:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:58:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:58:51 INFO - Running setup.py install for mozleak 15:58:51 INFO - Running setup.py install for mozlog 15:58:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:58:51 INFO - Running setup.py install for moznetwork 15:58:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:58:51 INFO - Running setup.py install for mozprocess 15:58:51 INFO - Running setup.py install for mozprofile 15:58:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:58:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:58:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:58:51 INFO - Running setup.py install for mozrunner 15:58:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:58:51 INFO - Running setup.py install for mozscreenshot 15:58:51 INFO - Running setup.py install for moztest 15:58:51 INFO - Running setup.py install for mozversion 15:58:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:58:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:58:52 INFO - Cleaning up... 15:58:52 INFO - Return code: 0 15:58:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:58: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')]} 15:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58: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')]} 15:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:52 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 0x7f93768e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c0790>, '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 0x19c1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b20>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', '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 15:58:52 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 15:58:52 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 15:58:52 INFO - Using env: {'DISPLAY': ':0', 15:58:52 INFO - 'HOME': '/home/cltbld', 15:58:52 INFO - 'LANG': 'en_US.UTF-8', 15:58:52 INFO - 'LANGUAGE': 'en_US:en', 15:58:52 INFO - 'LOGNAME': 'cltbld', 15:58:52 INFO - 'MAIL': '/var/mail/cltbld', 15:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:52 INFO - 'MOZ_NO_REMOTE': '1', 15:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:52 INFO - 'NO_EM_RESTART': '1', 15:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:52 INFO - 'PWD': '/builds/slave/test', 15:58:52 INFO - 'SHELL': '/bin/bash', 15:58:52 INFO - 'SHLVL': '1', 15:58:52 INFO - 'TERM': 'linux', 15:58:52 INFO - 'TMOUT': '86400', 15:58:52 INFO - 'USER': 'cltbld', 15:58:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', 15:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:52 INFO - '_': '/tools/buildbot/bin/python'} 15:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:58:52 INFO - Running setup.py (path:/tmp/pip-s9CZ5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:58:52 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)) 15:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:58:52 INFO - Running setup.py (path:/tmp/pip-COAzTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:58:52 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)) 15:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:58:52 INFO - Running setup.py (path:/tmp/pip-cxgPqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:58:52 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)) 15:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:58:52 INFO - Running setup.py (path:/tmp/pip-ueq4yX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:58:52 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)) 15:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:58:52 INFO - Running setup.py (path:/tmp/pip-5KZseZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:58:52 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)) 15:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:58:52 INFO - Running setup.py (path:/tmp/pip-9YwdWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:58:52 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)) 15:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:58:52 INFO - Running setup.py (path:/tmp/pip-aeo8kD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:58:52 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)) 15:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:58:52 INFO - Running setup.py (path:/tmp/pip-_hOhGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:58:52 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)) 15:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:58:52 INFO - Running setup.py (path:/tmp/pip-oYsPGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:58:52 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)) 15:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:58:52 INFO - Running setup.py (path:/tmp/pip-NNlWEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:58:53 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)) 15:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:58:53 INFO - Running setup.py (path:/tmp/pip-OpmNT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:58:53 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)) 15:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:58:53 INFO - Running setup.py (path:/tmp/pip-m_r6Gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:58:53 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)) 15:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:58:53 INFO - Running setup.py (path:/tmp/pip-M800rE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:58:53 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)) 15:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:58:53 INFO - Running setup.py (path:/tmp/pip-9eHiK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:58:53 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)) 15:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:58:53 INFO - Running setup.py (path:/tmp/pip-9g8DR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:58:53 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)) 15:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:58:53 INFO - Running setup.py (path:/tmp/pip-Qzke0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:58:53 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)) 15:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:58:53 INFO - Running setup.py (path:/tmp/pip-U5nWnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:58:53 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)) 15:58:53 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)) 15:58:53 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)) 15:58:53 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)) 15:58:53 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)) 15:58:53 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)) 15:58:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:58:53 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 15:58:53 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 15:58:53 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 15:58:53 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 15:58:53 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 15:58:53 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 15:58:55 INFO - Downloading blessings-1.6.tar.gz 15:58:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:58:55 INFO - Installing collected packages: blessings 15:58:55 INFO - Running setup.py install for blessings 15:58:55 INFO - Successfully installed blessings 15:58:55 INFO - Cleaning up... 15:58:55 INFO - Return code: 0 15:58:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:58:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:58:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:58:55 INFO - Reading from file tmpfile_stdout 15:58:55 INFO - Current package versions: 15:58:55 INFO - argparse == 1.2.1 15:58:55 INFO - blessings == 1.6 15:58:55 INFO - blobuploader == 1.2.4 15:58:55 INFO - docopt == 0.6.1 15:58:55 INFO - functools32 == 3.2.3-2 15:58:55 INFO - jsonschema == 2.5.1 15:58:55 INFO - manifestparser == 1.1 15:58:55 INFO - mozInstall == 1.12 15:58:55 INFO - mozcrash == 0.17 15:58:55 INFO - mozdebug == 0.1 15:58:55 INFO - mozdevice == 0.48 15:58:55 INFO - mozfile == 1.2 15:58:55 INFO - mozhttpd == 0.7 15:58:55 INFO - mozinfo == 0.9 15:58:55 INFO - mozleak == 0.1 15:58:55 INFO - mozlog == 3.4 15:58:55 INFO - moznetwork == 0.27 15:58:55 INFO - mozprocess == 0.23 15:58:55 INFO - mozprofile == 0.28 15:58:55 INFO - mozrunner == 6.12 15:58:55 INFO - mozscreenshot == 0.1 15:58:55 INFO - mozsystemmonitor == 0.3 15:58:55 INFO - moztest == 0.7 15:58:55 INFO - mozversion == 1.4 15:58:55 INFO - psutil == 3.1.1 15:58:55 INFO - requests == 1.2.3 15:58:55 INFO - wsgiref == 0.1.2 15:58:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:55 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 0x7f93768e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c0790>, '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 0x19c1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b20>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', '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 15:58:55 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 15:58:55 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 15:58:55 INFO - Using env: {'DISPLAY': ':0', 15:58:55 INFO - 'HOME': '/home/cltbld', 15:58:55 INFO - 'LANG': 'en_US.UTF-8', 15:58:55 INFO - 'LANGUAGE': 'en_US:en', 15:58:55 INFO - 'LOGNAME': 'cltbld', 15:58:55 INFO - 'MAIL': '/var/mail/cltbld', 15:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:55 INFO - 'MOZ_NO_REMOTE': '1', 15:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:55 INFO - 'NO_EM_RESTART': '1', 15:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:55 INFO - 'PWD': '/builds/slave/test', 15:58:55 INFO - 'SHELL': '/bin/bash', 15:58:55 INFO - 'SHLVL': '1', 15:58:55 INFO - 'TERM': 'linux', 15:58:55 INFO - 'TMOUT': '86400', 15:58:55 INFO - 'USER': 'cltbld', 15:58:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', 15:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:55 INFO - '_': '/tools/buildbot/bin/python'} 15:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:56 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)) 15:58:56 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)) 15:58:56 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)) 15:58:56 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)) 15:58:56 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)) 15:58:56 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)) 15:58:56 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)) 15:58:56 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)) 15:58:56 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)) 15:58:56 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)) 15:58:56 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)) 15:58:56 INFO - Cleaning up... 15:58:56 INFO - Return code: 0 15:58:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93768e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c0790>, '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 0x19c1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b20>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', '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 15:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:58:56 INFO - Using env: {'DISPLAY': ':0', 15:58:56 INFO - 'HOME': '/home/cltbld', 15:58:56 INFO - 'LANG': 'en_US.UTF-8', 15:58:56 INFO - 'LANGUAGE': 'en_US:en', 15:58:56 INFO - 'LOGNAME': 'cltbld', 15:58:56 INFO - 'MAIL': '/var/mail/cltbld', 15:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:56 INFO - 'MOZ_NO_REMOTE': '1', 15:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:56 INFO - 'NO_EM_RESTART': '1', 15:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:56 INFO - 'PWD': '/builds/slave/test', 15:58:56 INFO - 'SHELL': '/bin/bash', 15:58:56 INFO - 'SHLVL': '1', 15:58:56 INFO - 'TERM': 'linux', 15:58:56 INFO - 'TMOUT': '86400', 15:58:56 INFO - 'USER': 'cltbld', 15:58:56 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', 15:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:56 INFO - '_': '/tools/buildbot/bin/python'} 15:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:58:56 INFO - Cleaning up... 15:58:56 INFO - Return code: 0 15:58:56 INFO - Running post-action listener: _resource_record_post_action 15:58:56 INFO - Running post-action listener: _start_resource_monitoring 15:58:56 INFO - Starting resource monitoring. 15:58:56 INFO - [mozharness: 2016-10-19 22:58:56.473790Z] Finished create-virtualenv step (success) 15:58:56 INFO - [mozharness: 2016-10-19 22:58:56.474251Z] Running install step. 15:58:56 INFO - Running pre-action listener: _resource_record_pre_action 15:58:56 INFO - Running main action method: install 15:58:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:58:56 INFO - Reading from file tmpfile_stdout 15:58:56 INFO - Detecting whether we're running mozinstall >=1.0... 15:58:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:58:56 INFO - Reading from file tmpfile_stdout 15:58:56 INFO - Output received: 15:58:56 INFO - Usage: mozinstall [options] installer 15:58:56 INFO - Options: 15:58:56 INFO - -h, --help show this help message and exit 15:58:56 INFO - -d DEST, --destination=DEST 15:58:56 INFO - Directory to install application into. [default: 15:58:56 INFO - "/builds/slave/test"] 15:58:56 INFO - --app=APP Application being installed. [default: firefox] 15:58:56 INFO - mkdir: /builds/slave/test/build/application 15:58:56 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'] 15:58:56 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 15:59:13 INFO - Reading from file tmpfile_stdout 15:59:13 INFO - Output received: 15:59:13 INFO - /builds/slave/test/build/application/firefox/firefox 15:59:13 INFO - Running post-action listener: _resource_record_post_action 15:59:13 INFO - [mozharness: 2016-10-19 22:59:13.699747Z] Finished install step (success) 15:59:13 INFO - [mozharness: 2016-10-19 22:59:13.699988Z] Running run-tests step. 15:59:13 INFO - Running pre-action listener: _resource_record_pre_action 15:59:13 INFO - Running main action method: run_tests 15:59:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:59:13 INFO - Python 2.7.3 15:59:13 INFO - Return code: 0 15:59:13 INFO - grabbing minidump binary from tooltool 15:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:13 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 0x19c0790>, '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 0x19c1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:59:13 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 15:59:13 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 15:59:13 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 15:59:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:59:13 INFO - Return code: 0 15:59:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:59:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:59:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:59:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:59:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:59:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 15:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 15:59:13 INFO - Using env: {'DISPLAY': ':0', 15:59:13 INFO - 'HOME': '/home/cltbld', 15:59:13 INFO - 'LANG': 'en_US.UTF-8', 15:59:13 INFO - 'LANGUAGE': 'en_US:en', 15:59:13 INFO - 'LOGNAME': 'cltbld', 15:59:13 INFO - 'MAIL': '/var/mail/cltbld', 15:59:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:59:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:13 INFO - 'MOZ_NO_REMOTE': '1', 15:59:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:13 INFO - 'NO_EM_RESTART': '1', 15:59:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:13 INFO - 'PWD': '/builds/slave/test', 15:59:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:59:13 INFO - 'SHELL': '/bin/bash', 15:59:13 INFO - 'SHLVL': '1', 15:59:13 INFO - 'TERM': 'linux', 15:59:13 INFO - 'TMOUT': '86400', 15:59:13 INFO - 'USER': 'cltbld', 15:59:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065', 15:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:13 INFO - '_': '/tools/buildbot/bin/python'} 15:59:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 15:59:13 INFO - mozversion application_buildid: 20161019123223 15:59:13 INFO - mozversion application_changeset: babb18c5b2a7af9f9fe5c1c8e88d580f48d3a001 15:59:13 INFO - mozversion application_display_name: Nightly 15:59:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:59:13 INFO - mozversion application_name: Firefox 15:59:13 INFO - mozversion application_remotingname: firefox 15:59:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:59:13 INFO - mozversion application_vendor: Mozilla 15:59:13 INFO - mozversion application_version: 52.0a1 15:59:13 INFO - mozversion platform_buildid: 20161019123223 15:59:13 INFO - mozversion platform_changeset: babb18c5b2a7af9f9fe5c1c8e88d580f48d3a001 15:59:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:59:13 INFO - mozversion platform_version: 52.0a1 15:59:13 INFO - using testdate: 1476917953 15:59:13 INFO - actual date: 1476917953 15:59:13 INFO - starting webserver on 'localhost:54668' 15:59:13 INFO - SUITE-START | Running 2 tests 15:59:13 INFO - TEST-START | dromaeo_css 15:59:13 INFO - operating with platform_type : linux_ 15:59:13 INFO - Initialising browser for dromaeo_css test... 15:59:13 INFO - TEST-INFO | started process 14706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUnseqX/profile http://localhost:54668/getInfo.html) 15:59:18 INFO - PROCESS | 14706 | __metrics Screen width/height:1600/1200 15:59:18 INFO - PROCESS | 14706 | colorDepth:24 15:59:18 INFO - PROCESS | 14706 | Browser inner width/height: 1024/697 15:59:18 INFO - PROCESS | 14706 | __metrics 15:59:18 ERROR - PROCESS | 14706 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 15:59:19 INFO - TEST-INFO | 14706: exit 0 15:59:19 INFO - Browser initialized. 15:59:19 INFO - Running cycle 1/1 for dromaeo_css test... 15:59:19 INFO - TEST-INFO | started process 14827 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUnseqX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:32 INFO - PROCESS | 14827 | RSS: Main: 183132160 15:59:32 INFO - PROCESS | 14827 | 16:00:21 INFO - PROCESS | 14827 | 1476918021801 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:02:32 INFO - PROCESS | 14827 | Cycle 1(1): loaded http://localhost:54668/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54668/tests/dromaeo/cssquery-ext.html) 16:02:34 INFO - PROCESS | 14827 | RSS: Main: 196784128 16:02:34 INFO - PROCESS | 14827 | 16:05:36 INFO - PROCESS | 14827 | Cycle 1(1): loaded http://localhost:54668/tests/dromaeo/cssquery-ext.html (next: http://localhost:54668/tests/dromaeo/cssquery-jquery.html) 16:05:36 INFO - PROCESS | 14827 | RSS: Main: 194957312 16:05:36 INFO - PROCESS | 14827 | 16:08:38 INFO - PROCESS | 14827 | Cycle 1(1): loaded http://localhost:54668/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54668/tests/dromaeo/cssquery-mootools.html) 16:08:39 INFO - PROCESS | 14827 | RSS: Main: 196943872 16:08:39 INFO - PROCESS | 14827 | 16:11:41 INFO - PROCESS | 14827 | Cycle 1(1): loaded http://localhost:54668/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54668/tests/dromaeo/cssquery-prototype.html) 16:11:41 INFO - PROCESS | 14827 | RSS: Main: 193413120 16:11:41 INFO - PROCESS | 14827 | 16:14:44 INFO - PROCESS | 14827 | Cycle 1(1): loaded http://localhost:54668/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54668/tests/dromaeo/cssquery-yui.html) 16:14:45 INFO - PROCESS | 14827 | RSS: Main: 197419008 16:14:45 INFO - PROCESS | 14827 | 16:17:47 INFO - PROCESS | 14827 | Cycle 1(1): loaded http://localhost:54668/tests/dromaeo/cssquery-yui.html (next: http://localhost:54668/tests/dromaeo/cssquery-dojo.html) 16:17:47 INFO - PROCESS | 14827 | RSS: Main: 196820992 16:17:47 INFO - PROCESS | 14827 | 16:17:47 INFO - PROCESS | 14827 | __start_tp_report 16:17:47 INFO - PROCESS | 14827 | _x_x_mozilla_page_load 16:17:47 INFO - PROCESS | 14827 | _x_x_mozilla_page_load_details 16:17:47 INFO - PROCESS | 14827 | |i|pagename|runs| 16:17:47 INFO - PROCESS | 14827 | |0;dojo.html;3071.969280307197;3088.675689052648;3117.5947126873502;3124.2814152744877;3139.246580820604;5123.462036486171;5268.762905669249;5339.385970613375;5413.566914646829;5427.728613569316;5177.844664660057;5230.084735171339;5258.973705131479;5279.340082489689;5300.363956325236;4801;4845.563899249076;4897.853064408074;4905.23968784839;4979.402471703383;4803.495632958541;4919.065377578267;4976.900461990758;4997.325361076245;5015.774290156952;4817.686850354751;4855.854324370274;4873.805047798084;4911.361523002022;4916.1888288432365;4712.952870471286;4787.736674482902;4801.783919723621;4828.106800241966;4833.371661683958;4684.250519916797;4806.399200099988;4806.927896081562;4848.636352273594;4858.757062146914;5362.973185134088;5388.946110538923;5412.512873841373;5415.6479828811;5473.370562385337;5624.437556244343;5738.684372359518;5769.88460230793;5769.9711501442225;5771.192033115325;5715.199872017921;5723.5421166307015;5740.483356497935;5744.827655170351;5799.855003624901;5290.100682883919;5356.544693701079;5362.758675859557;5368.355797304271;5370.167624018283;5681.176229446707;5713.857153571111;5761.107028410603;5829.621074630136;5848.5884263918615;5535.612507124462;5555.2778138841695;5556.055470570012;5586.692731899784;5615.101583746581;5597.132444471114;5599.7480113394995;5612.915806262909;5619.381867994599;5621.578381621394;5517.393086760453;5557.916631250535;5723.370429252779;5752.050911599623;5755.85610359736;5795.33353664334;5797.101449275369;5804.477597016289;5818.214541036906;5819.476247137778;4429.313456414261;4442.644588432918;4448.733076015449;4450.465944086665;4493.932591011137;3841.769493830379;3847.461355410245;3848.1534062506203;3853.3641949078087;3986.402039694011;5334.466553344712;5366.543843773323;5369.919451208235;5400.324959380077;5406.702631355313;5568.136938774496;5608.9439105609235;5650.378458369576;5651.350094739076;5663.207150998864;5369.570434365241;5380.085385484477;5394.029074766501;5427.6472029317965;5437.918431223535;4923.286123512143;4943.357363542788;4955.950440495621;4963.379577552806;5022;5914.408559144224;5926.940730592639;5939.13882487037;5941.792037278588;5968.612040217372;5476.397596264328;5799.82600521985;5812.070068788974;5835.299764028174;5861.9706901465215;5658.519025882846;5835.387284335254;5843.561732870136;5917.082852157922;5969.432903874125;5562.276904002454;5564.081926482085;5565.1095824667855;5565.1095824667855;5565.805196818092;5616.803411880564;5663.688497132533;5687.146927960839;5694.1458781183155;5696.458836410535;5395.433479484597;5430.429804870431;5492.1212605982855;5528.585356098229;5570.275864137636;5507.889842203053;5530.308711411074;5551.306086739158;5562.360328562268;5596.440355964371;5390.245365648891;5456.208849716848;5486.972565137149;5522.088855338824;5532.972335138298;5557.110862262019;5612.915806262828;5641.9435805641415;5650.971745141413;5744.540436764965;5624.465675760796;5625.409332020079;5630.4369563043365;5632.549396048388;5639.54883609302 16:17:47 INFO - PROCESS | 14827 | |1;ext.html;559.3762954305948;587.8941790477712;592.7865968251429;596.4482853360643;601.029337619744;41312.58687413125;43154.784226078904;43175.13649727003;46751;47003.764981175045;44376.11247775042;44724.776376118076;44817;44824.55175448245;44835.32747008789;8844.823103537909;9006.729798106067;9013.459192448474;9013.54932253388;9014.54927253638;8877.422967507091;8931.55342232889;8960.507172105532;8962.283017358595;8965.865512017324;8974.955125224365;8977.236934860544;8989.775255618597;9002.954985225064;9004.909950900472;8889.77775555613;8917.152870477294;8922.375433719642;8949.105089491064;8952.68665596701;8767.78080547985;8837.160469755363;8854.911450885473;8874.733757987271;8875.423097498706;41580.37629435561;41760.164796703895;41915;41948.79025604852;42070.579294206975;3445.3798316303055;3509.5613048368955;3676.7242456815848;3759.8496060157563;3965.6629186518894;30809;30814.845925770453;30951.69048309533;31002.379952400825;32901.3419731604;3773.981130094332;3810.4093865450623;3817.9809100954317;3944.5463771666336;3992.480977472939;320972;322958.3852080748;323241;323733;324774;50472;56946.71526642423;57025.71487142621;57238;57251.99999999916;59900.70049649724;60073.699631501564;60092.399076009555;60311.69844150751;60424;15290.694186116438;15545.922270388803;15551.377944882304;15577;15635.3745850167;11953.46209420578;12027.699307517207;12032.458539365574;12035.217710848767;12081.57714479989;16368.83631163697;16711.331546737994;16937.661246774995;17031.659366812593;17189.656206876043;3105.3634005029367;5983.640981541034;6118.5716999810475;6227.419233940503;6307.842303942438;934.495372498843;941.6939494664261;974.5565767575736;994.0953732103751;1108.6673997800629;31314.373712525623;31391.21521961969;31462.34776003064;31662.208444789063;31683.84158079241;1058.6241884131023;1071.8338657508098;1073.5544748929108;1081.6754973507916;1124.1793490751797;15340.539783806504;16466;16485;16526.182119966794;16695.66608667844;520402;522429;524382;526717;530816;57779.71110144423;57885;58046.7097664509;58458.707706461195;58471.99999999915;1259.1815320042047;1296.9286689232183;1311.252586025975;1324.4635922451616;1329.0364485747755;29174.27064323409;30333.393332132793;30518.84740576283;30778.38443231078;31001.224969375948;50895.2365714522;51110.488895110575;51496.74251628718;51607.741961289954;51846.481535185674;433581;433617;433972;435874;436721;26397.604035939094;27156;27279.86360068187;27446.5883011751;27755.306117347227;44884.551154489345;45344.54655453535;50577;50734.49265507298;52221.7388913053;40100;40596.39105413362;40723.38914916219;40897;43046.78476607597;39693.04604309377;41552;41625.167496649294;41804.58195418007;41937;38422;39741.60258397495;40357.39463907985;40409.1918161641;40602.39096413497;33231.667683322856;35883.641163589076;37239.94486657043;37641.43537846989;37794.24411511699;27607.58588621132;27892.721072789012;28062;28140.85929570421;28240.43519129647 16:17:47 INFO - PROCESS | 14827 | |2;jquery.html;378.89390970528245;383.2794346628338;391.6240409207162;392.92730844793715;418.3432011741565;14409.639759006004;17785.91107044466;17894.194761235743;19495.122719477622;19527.023648817554;17466.388676396327;17762;18559.164837582306;18697.34559290425;18749.156287967042;5167.767450464738;5327.920081198785;5580.274564306635;5863.618864773776;5955.7790652916265;5900.262467191601;5921.851953701149;5931.288245410557;5936.64380137191;5947.464728174464;5679.829605111853;5772.769089236425;5803.390643982384;5816.360200377955;5852.239208902836;5664.235328230678;5866.73599688015;5877.823665290048;5904.110684580935;5912.940870591282;5603.495685388294;5648.293963254593;5651.9152212716845;5657.179708942222;5669.0646043402785;13714.65713357164;13970.92639619282;20799.896000520053;21796.45508862275;22001.66997495039;2261.5476904618977;2294.7705229477087;2300.5973954558053;2830.5754136879427;2933.3399985003416;9733.415995040321;9815.656452024215;10036.89963100367;10171.440570768606;10375.325603835801;1846.6214426042764;1934.9129289182022;1944.854135939796;1952.306931039489;1978.4163671716735;73134;74425.25574744238;79742.60128699377;81342.18657813405;83712.16287837105;10541.84187237192;10721.83917241242;10802.621908233174;11008.724781880517;11130.276532025393;13211.471541138248;15094.16982065975;15174.924125379302;15226;15256.313465894062;6703.798886033427;7594.430417718693;7802.180771019075;7840.098388685375;7971.720989765447;7157.89263161053;7176.7846964591145;7253.782386528413;7412.073490813648;7522.6614802334025;4633.868420526595;4634.675572709878;4709.105269998689;4737.881552961204;4773.212419950739;1946.1294590479213;1958.3048017953422;1973.8026197380148;1979.7129416234566;2005.8295044921344;861.1345597674423;887.2059506741431;942.072059021863;947.6777895515557;1023.6775415744165;18071.909640451977;18609.44171674852;18769.7184542232;18955.052247387575;19144.042797860053;918.3066784577601;929.5491686532026;942.2556180617372;993.7863359377768;1013.5135135135029;10119.949400252952;10508.842367364496;10658.467076646291;10730.19523535738;10817.134629229642;427755;442867;445503;446099;446731;79757;87180;88034;88328.55835720908;88857;982.1700662939804;983.8524221366853;993.3245393132739;1000.2248257600418;1047.2930771729204;16523.752143717615;16795.664086718443;17258.568535786704;17531.912340438215;17639;36460.45309320415;42884.14231715286;43144.78427607842;43387.78306108449;44340.33489497725;48903;53610.19584706311;54544;54964.17553736777;55179;8239.629216685384;8365.832683346178;8395.118512556093;8498.490090594583;8605.65577376898;12129.454174562343;12853.228806271654;13076.738465230832;13205.471781129032;13438;11304.265222760494;11392.829107563228;11423.314601123959;11503.252288601214;11507.884921150682;11264.66206013821;11480.598179063692;11646;11663.825042624198;11762.647120586396;6482.157319548617;8203.507789532408;11333.603323883624;11368.679901637324;11615.6515304541;7074.610896400747;7354.595497247703;7519.586422746802;8062.395320351115;8376.958115209629;8478.448900821428;10322.638707645196;10968.23222374458;11124.499397526968;11525.942370288094 16:17:47 INFO - PROCESS | 14827 | |3;mootools.html;1458.2052781234227;1489.9627509312265;1641.4419097506845;1780.0120932882246;1805.38616870264;8007.879881801763;8292.792680182984;8580.74257772267;9163.862542061874;9174.082591740831;8654.22112009919;8846.601902914368;8861.113888611135;9131.132542408477;9162.541872906362;2315.224399826056;2339.064374250305;2339.7660233976635;2342.0397636968846;2348.2602980061224;2283.6117859963765;2285.8514196577253;2353.035255545227;2360.5160942006846;2363.196513185517;2303.3550605830396;2309.064828744353;2310.5378924215142;2349.8472599281076;2364.8344615876895;2219.4007617943143;2254.5378197469645;2262.2760716570706;2263.6944012558342;2323.61660326046;2239.3505883293824;2241.955160896789;2249.5051088760447;2251.279590531031;2266.478709896733;9223.67717129904;9224.677136300264;9254;9267.582958766872;9295.442273463614;5360.946390536123;5480.205370221335;5505.421930697299;5511.58663100269;5550.306211723535;3295.489199174132;3344.528407500716;3455.188030812757;3466.5146879436898;3475.409180439306;1023.6826583759058;1051.2273478992934;1059.8463222832722;1070.7055559721139;1094.0919037199105;12993.480260789556;13040.347982600926;13059.020573457028;13068.803967940583;13070.477180912752;4550.294704320836;4637.118947399983;4795.736234507136;4855.393075865517;4859.902801944012;10885.455727213608;10903;10916.290441121302;10919.39943303126;10920.945395273131;5397.946020539823;5402.756875940592;5440.3743569489225;5450.700211488406;5456.699881506555;4312.159128969884;4458.353538736865;4811.975940120277;4884.511548845158;4970.527799859007;3831.233753249361;3897.279003384326;3951.4665520154986;3953.0710283083454;3958.9010274743364;1220.7436438348047;1244.3778110944527;1254.0782524844233;1279.0918447902093;1283.5315109984788;785.6032703484703;958.2094771813282;977.3842479238034;984.3650845204803;1006.411249419098;5805.767769289266;5869.216588480374;5957.493613042853;6155.753769849156;6220.253569571681;411.66449343784717;419.29976938512755;419.40653974625565;425.07546087260084;426.3242760225016;4151.522574903925;4194.664426845845;4223.070924396628;4240.639545638655;4269.4449721536;11176.552937882394;11418;11520.423978801027;11522.711932201595;11538.307701537935;11440.542378304775;11446.828297575543;11448.484818183202;11475.483603237873;11529.48117334722;8125.75622731319;8491.74524764258;8496.787580310418;8535.871961920577;8539.615717292736;6063.636181829104;6278.215223097113;6345.1116843641;6347.809565713036;6349.0476428536085;10110;10352.948235258775;10506.842397364198;10522.631707890187;10531.684049478528;10675.733106672395;10677.51951162184;10688.465576720977;10714.196435267542;10719.874413186502;7183.820404489929;7409.62951852416;7447.32974032318;8038.83922321562;8084.595770211348;8085.393595480245;8358.498490090615;8463.36524760633;8464.619092140745;8474.110218426977;7478.4765066447;7488.925110748823;7552.886706699294;7604.543727376154;7737.6518056686455;7262.709491620276;7556.622168891643;7635.656395462106;7682.577458239851;7704.036995375578;7176.067111275501;7222.241664625349;7281.854362912818;7306.013688152031;7308.086489188851;5093.541581257705;5130.743462826918;5143.202803565453;5227.111391063604;5330.493603107699;5037.4887533739;5167.302414174189;5175.896482070262;5183.844484665466;5256.894862102813 16:17:47 INFO - PROCESS | 14827 | |4;prototype.html;321.800483700106;331.1621597358682;333.1371747174817;337.12852276864305;337.95606571145754;5460.590455715817;5483.122700367942;5556.833295001152;5600.747966341514;5610.747516361764;5395.757190926408;5434.538064264532;5444.945550544493;5465.180222966547;5498.615096943216;4270.508891477481;4297.763623000734;4304.160688665712;4307.741535507864;4328.610425061744;4124.216398884218;4250.149970005996;4322.82708691652;4330.501992270898;4351.347297905324;4194.559571245021;4212.304969679999;4214.578542145776;4216.536181020086;4230.555791641864;4214.704970652071;4218.409422680827;4232.343986682069;4239.660827133822;4246.639035681971;3745.4756334113245;3750.6999440044733;3762.3415902217275;3779.433085037266;3781.810909454544;5159.58723302135;5338.466153384669;5339.982909656071;5367.1680889462195;5433.483819037185;4774.73738944358;4832.106060378841;4852.587530059949;4878.902421951541;4885.804567817283;5453.863653408657;5735.369109397963;5739.3973632768375;5742.908847318996;5762.74067666956;4018.3972404139613;4029.677625789959;4038.9798051009852;4041.5756345583877;4045.554988951213;5962.821115366546;6002.2197114375285;6011.609245399035;6034.456898879078;6043.788467403664;3919.510061242345;4197.328427451593;4209.726367786084;4210.736778966298;4214.578542145822;4134.37984302357;4161.875143745692;4184.681825225044;4196.853110141131;4200.285951388271;4788.3056956741775;4816.735079570657;4825.638077144228;4835.709857408567;4835.782389792468;5510.614257001971;5655.4910058094965;5711.571632127607;5722.939741692987;5723.713814309268;1401.3343661760787;1431.7923901034292;1437.0802686280788;1437.8001657464097;1442.235615123986;893.9016708162097;912.6811757011188;916.5279880861361;935.4667839331515;952.1573407534244;4792.592629626451;4799.976000120047;4809.519048095162;4913.329467980903;5000.174971129795;4985.501449854985;5060.861306206074;5086.906315142262;5089.287499750038;5089.567386772092;4853.699484350675;4873.366462359871;4948.4309304429735;4958.752062396866;5300.257963885059;3111.782175247756;3129.3741251749284;3142.9528557071662;3167.445697003015;3167.6040494938134;6105.992511235597;6132.7121304526545;6142.3550527194;6180.567360284737;6185.597936134227;5873.911891321633;5903.7048147593305;5922.318933322636;5926.259217597801;5933.465988061095;6003.309619393738;6025.614108755011;6037.275526936708;6117.755289788448;6126.264848218242;5534.944650553443;5800.651960882361;5865.765369385347;5882.499987500939;5892.234009578899;5747.166660834072;5768;5781.82654520365;5784.421557844182;5786.681732504752;6084.300305464928;6092.390760923872;6107.725152368065;6123.387661233841;6137.84655383619;3883.087474443447;3994.7403418777685;4048;4051.8379264829077;4061.2892743770312;5810.302763668386;5818.73815678304;5828.6211396259105;5841.153032810304;5887.558433117619;5491.395946445808;5749.8562535936935;5762.567807414377;5769.336526299361;5778.248827652378;5665.376808551138;5684.602077854511;5703.771849126155;5719.142128680731;5738.913916291175;5708.172315014217;5721.1990321354215;5727.971360143172;5796.855078623068;5825.883482330414;5648.830535083954;5690.5163061140265;5695.288088988877;5777.422257774189;5789.163309978165;5633.436656334334;5641.887162256649;5642.717864106696;5646.971765141148;5655.208270842003 16:17:47 INFO - PROCESS | 14827 | |5;yui.html;714.8562300319493;740.2116745665866;765.3647472597744;796.5021861336664;820.7619790260825;14385.208813515252;15416.460423885166;15434.382624695012;15547.844521554782;15556.299966501507;13652.726945461085;13661.863381366184;13772.655683607914;13788.034837561374;13813.723725525484;790.6165509727763;799.436397339874;811.1766556944706;816.1593558634615;816.2572059425923;800.5236884053978;805.5327909812295;807.3097501636105;807.3460496997421;808.1635507249997;845.3237410071948;847.2205570874779;849.0024221539666;850.6384786465758;850.9703259056519;840.4201101240125;847.8092429203441;847.821957388949;848.1687945813076;849.2526576612603;629.3046183966696;629.3580547841223;629.4272212286797;629.8173529676388;630.3035146163469;13250.138740981805;13420.32898355088;13462.394192261372;13541.526046588322;13648.658783530393;13027.218366898016;13339.666508337272;13355.933220333933;13698;14063.2968351582;12987.545435909793;13344.132631378929;13394.129381590166;13472.461101555926;13500.662483437894;3796.8671096511766;3926.5877082906454;4488.169688607585;4539.977300113478;4589.79345929434;64531.677341612994;64670;66541.334586654;72914;75263.62368188179;11343.432828358715;11426.88573114275;11483.08207038024;11560.190786645022;11563.750217429151;20417.79582204159;20464.38606841797;20493.180272788923;20514.487137821674;20545.383638490868;8139.348852091818;8151.91158395495;8175;8269.131741167092;8388.496690198608;4654.27858681898;4699.342092107107;4735.952640473552;4748.810047598057;4973.502649734997;3666.7249956253386;3746.494223279822;3774.0753515388906;3804.1250512381753;3812.275667623143;651.2120334395435;675.5811396933834;675.6655455549436;689.6034780001519;695.4575431163701;699.9020137180798;724.9601271929989;741.9554826710307;743.1862110988459;745.2770812312049;9038.231750301298;9243.26053915685;9384.828655328085;9624.51877406127;9681.983391743766;696.3384784454788;712.8289210589525;720.7657511308846;733.2923728601925;740.3521918321469;4658.58072773452;4686.27362758773;4749.833755818529;4762.809487620526;4776.331313616097;121200;122785.38607306906;122941;124496.15271159992;127052;105080.86489188852;106280;109500;112193.43903280431;113793;77085.99999999888;80423;93514.53242733743;93773;93874;8575.099614540633;8952.507612081137;9053.321000924825;9085.90914090877;9164.175224229852;48772;48882.26676599925;50121;50162;50721.74639126781;66046;71007.64496177486;71583.64208178926;73498.63250683712;74425;12272.325022123512;12605.873941260837;12699.746005080031;12703.174293670882;12765.170263932814;14182.645433864236;14210.573682789533;14314.713705726035;14475.710485790436;14647.12117272967;13021.414036368576;13023.283719395145;13225.206487610774;13509.864901351253;13610.795838062635;13642.658933526742;13806;14500.564983050524;14586.270686465847;14587.708245835236;12940.935295323463;13035.15271507349;13258.469661213443;13312.267825269315;13849.515266965607;10791.514381852992;10849.67450976472;11064.834027489433;11208.607698730506;11250.831237531607;11072.446377680923;11111.944440277746;11243.831342530033;11373.431328433711;11400.771984560428 16:17:47 INFO - PROCESS | 14827 | __end_tp_report 16:17:47 INFO - PROCESS | 14827 | __start_cc_report 16:17:47 INFO - PROCESS | 14827 | _x_x_mozilla_cycle_collect,313 16:17:47 INFO - PROCESS | 14827 | __end_cc_report 16:17:47 INFO - PROCESS | 14827 | __startTimestamp1476919067970__endTimestamp 16:17:47 INFO - PROCESS | 14827 | 16:17:47 INFO - PROCESS | 14827 | ------- Summary: start ------- 16:17:47 INFO - PROCESS | 14827 | Number of tests: 6 16:17:47 INFO - PROCESS | 14827 | 16:17:47 INFO - PROCESS | 14827 | [#0] dojo.html Cycles:165 Average:5299.37 Median:5507.89 stddev:592.96 (10.8%) stddev-sans-first:568.45 16:17:47 INFO - PROCESS | 14827 | Values: 3072.0 3088.7 3117.6 3124.3 3139.2 5123.5 5268.8 5339.4 5413.6 5427.7 5177.8 5230.1 5259.0 5279.3 5300.4 4801.0 4845.6 4897.9 4905.2 4979.4 4803.5 4919.1 4976.9 4997.3 5015.8 4817.7 4855.9 4873.8 4911.4 4916.2 4713.0 4787.7 4801.8 4828.1 4833.4 4684.3 4806.4 4806.9 4848.6 4858.8 5363.0 5388.9 5412.5 5415.6 5473.4 5624.4 5738.7 5769.9 5770.0 5771.2 5715.2 5723.5 5740.5 5744.8 5799.9 5290.1 5356.5 5362.8 5368.4 5370.2 5681.2 5713.9 5761.1 5829.6 5848.6 5535.6 5555.3 5556.1 5586.7 5615.1 5597.1 5599.7 5612.9 5619.4 5621.6 5517.4 5557.9 5723.4 5752.1 5755.9 5795.3 5797.1 5804.5 5818.2 5819.5 4429.3 4442.6 4448.7 4450.5 4493.9 3841.8 3847.5 3848.2 3853.4 3986.4 5334.5 5366.5 5369.9 5400.3 5406.7 5568.1 5608.9 5650.4 5651.4 5663.2 5369.6 5380.1 5394.0 5427.6 5437.9 4923.3 4943.4 4956.0 4963.4 5022.0 5914.4 5926.9 5939.1 5941.8 5968.6 5476.4 5799.8 5812.1 5835.3 5862.0 5658.5 5835.4 5843.6 5917.1 5969.4 5562.3 5564.1 5565.1 5565.1 5565.8 5616.8 5663.7 5687.1 5694.1 5696.5 5395.4 5430.4 5492.1 5528.6 5570.3 5507.9 5530.3 5551.3 5562.4 5596.4 5390.2 5456.2 5487.0 5522.1 5533.0 5557.1 5612.9 5641.9 5651.0 5744.5 5624.5 5625.4 5630.4 5632.5 5639.5 16:17:47 INFO - PROCESS | 14827 | 16:17:47 INFO - PROCESS | 14827 | [#1] ext.html Cycles:180 Average:58815.23 Median:41692.67 stddev:115487.38 (277.0%) stddev-sans-first:115728.52 16:17:47 INFO - PROCESS | 14827 | Values: 559.4 587.9 592.8 596.4 601.0 41312.6 43154.8 43175.1 46751.0 47003.8 44376.1 44724.8 44817.0 44824.6 44835.3 8844.8 9006.7 9013.5 9013.5 9014.5 8877.4 8931.6 8960.5 8962.3 8965.9 8975.0 8977.2 8989.8 9003.0 9004.9 8889.8 8917.2 8922.4 8949.1 8952.7 8767.8 8837.2 8854.9 8874.7 8875.4 41580.4 41760.2 41915.0 41948.8 42070.6 3445.4 3509.6 3676.7 3759.8 3965.7 30809.0 30814.8 30951.7 31002.4 32901.3 3774.0 3810.4 3818.0 3944.5 3992.5 320972.0 322958.4 323241.0 323733.0 324774.0 50472.0 56946.7 57025.7 57238.0 57252.0 59900.7 60073.7 60092.4 60311.7 60424.0 15290.7 15545.9 15551.4 15577.0 15635.4 11953.5 12027.7 12032.5 12035.2 12081.6 16368.8 16711.3 16937.7 17031.7 17189.7 3105.4 5983.6 6118.6 6227.4 6307.8 934.5 941.7 974.6 994.1 1108.7 31314.4 31391.2 31462.3 31662.2 31683.8 1058.6 1071.8 1073.6 1081.7 1124.2 15340.5 16466.0 16485.0 16526.2 16695.7 520402.0 522429.0 524382.0 526717.0 530816.0 57779.7 57885.0 58046.7 58458.7 58472.0 1259.2 1296.9 1311.3 1324.5 1329.0 29174.3 30333.4 30518.8 30778.4 31001.2 50895.2 51110.5 51496.7 51607.7 51846.5 433581.0 433617.0 433972.0 435874.0 436721.0 26397.6 27156.0 27279.9 27446.6 27755.3 44884.6 45344.5 50577.0 50734.5 52221.7 40100.0 40596.4 40723.4 40897.0 43046.8 39693.0 41552.0 41625.2 41804.6 41937.0 38422.0 39741.6 40357.4 40409.2 40602.4 33231.7 35883.6 37239.9 37641.4 37794.2 27607.6 27892.7 28062.0 28140.9 28240.4 16:17:47 INFO - PROCESS | 14827 | 16:17:47 INFO - PROCESS | 14827 | [#2] jquery.html Cycles:180 Average:26921.82 Median:235319.57 stddev:72989.58 (31.0%) stddev-sans-first:73167.12 16:17:47 INFO - PROCESS | 14827 | Values: 378.9 383.3 391.6 392.9 418.3 14409.6 17785.9 17894.2 19495.1 19527.0 17466.4 17762.0 18559.2 18697.3 18749.2 5167.8 5327.9 5580.3 5863.6 5955.8 5900.3 5921.9 5931.3 5936.6 5947.5 5679.8 5772.8 5803.4 5816.4 5852.2 5664.2 5866.7 5877.8 5904.1 5912.9 5603.5 5648.3 5651.9 5657.2 5669.1 13714.7 13970.9 20799.9 21796.5 22001.7 2261.5 2294.8 2300.6 2830.6 2933.3 9733.4 9815.7 10036.9 10171.4 10375.3 1846.6 1934.9 1944.9 1952.3 1978.4 73134.0 74425.3 79742.6 81342.2 83712.2 10541.8 10721.8 10802.6 11008.7 11130.3 13211.5 15094.2 15174.9 15226.0 15256.3 6703.8 7594.4 7802.2 7840.1 7971.7 7157.9 7176.8 7253.8 7412.1 7522.7 4633.9 4634.7 4709.1 4737.9 4773.2 1946.1 1958.3 1973.8 1979.7 2005.8 861.1 887.2 942.1 947.7 1023.7 18071.9 18609.4 18769.7 18955.1 19144.0 918.3 929.5 942.3 993.8 1013.5 10119.9 10508.8 10658.5 10730.2 10817.1 427755.0 442867.0 445503.0 446099.0 446731.0 79757.0 87180.0 88034.0 88328.6 88857.0 982.2 983.9 993.3 1000.2 1047.3 16523.8 16795.7 17258.6 17531.9 17639.0 36460.5 42884.1 43144.8 43387.8 44340.3 48903.0 53610.2 54544.0 54964.2 55179.0 8239.6 8365.8 8395.1 8498.5 8605.7 12129.5 12853.2 13076.7 13205.5 13438.0 11304.3 11392.8 11423.3 11503.3 11507.9 11264.7 11480.6 11646.0 11663.8 11762.6 6482.2 8203.5 11333.6 11368.7 11615.7 7074.6 7354.6 7519.6 8062.4 8377.0 8478.4 10322.6 10968.2 11124.5 11525.9 16:17:47 INFO - PROCESS | 14827 | 16:17:47 INFO - PROCESS | 14827 | [#3] mootools.html Cycles:180 Average:5915.46 Median:4290.80 stddev:3476.29 (81.0%) stddev-sans-first:3469.91 16:17:47 INFO - PROCESS | 14827 | Values: 1458.2 1490.0 1641.4 1780.0 1805.4 8007.9 8292.8 8580.7 9163.9 9174.1 8654.2 8846.6 8861.1 9131.1 9162.5 2315.2 2339.1 2339.8 2342.0 2348.3 2283.6 2285.9 2353.0 2360.5 2363.2 2303.4 2309.1 2310.5 2349.8 2364.8 2219.4 2254.5 2262.3 2263.7 2323.6 2239.4 2242.0 2249.5 2251.3 2266.5 9223.7 9224.7 9254.0 9267.6 9295.4 5360.9 5480.2 5505.4 5511.6 5550.3 3295.5 3344.5 3455.2 3466.5 3475.4 1023.7 1051.2 1059.8 1070.7 1094.1 12993.5 13040.3 13059.0 13068.8 13070.5 4550.3 4637.1 4795.7 4855.4 4859.9 10885.5 10903.0 10916.3 10919.4 10920.9 5397.9 5402.8 5440.4 5450.7 5456.7 4312.2 4458.4 4812.0 4884.5 4970.5 3831.2 3897.3 3951.5 3953.1 3958.9 1220.7 1244.4 1254.1 1279.1 1283.5 785.6 958.2 977.4 984.4 1006.4 5805.8 5869.2 5957.5 6155.8 6220.3 411.7 419.3 419.4 425.1 426.3 4151.5 4194.7 4223.1 4240.6 4269.4 11176.6 11418.0 11520.4 11522.7 11538.3 11440.5 11446.8 11448.5 11475.5 11529.5 8125.8 8491.7 8496.8 8535.9 8539.6 6063.6 6278.2 6345.1 6347.8 6349.0 10110.0 10352.9 10506.8 10522.6 10531.7 10675.7 10677.5 10688.5 10714.2 10719.9 7183.8 7409.6 7447.3 8038.8 8084.6 8085.4 8358.5 8463.4 8464.6 8474.1 7478.5 7488.9 7552.9 7604.5 7737.7 7262.7 7556.6 7635.7 7682.6 7704.0 7176.1 7222.2 7281.9 7306.0 7308.1 5093.5 5130.7 5143.2 5227.1 5330.5 5037.5 5167.3 5175.9 5183.8 5256.9 16:17:47 INFO - PROCESS | 14827 | 16:17:47 INFO - PROCESS | 14827 | [#4] prototype.html Cycles:180 Average:4761.46 Median:5434.01 stddev:1411.53 (26.0%) stddev-sans-first:1375.59 16:17:47 INFO - PROCESS | 14827 | Values: 321.8 331.2 333.1 337.1 338.0 5460.6 5483.1 5556.8 5600.7 5610.7 5395.8 5434.5 5444.9 5465.2 5498.6 4270.5 4297.8 4304.2 4307.7 4328.6 4124.2 4250.1 4322.8 4330.5 4351.3 4194.6 4212.3 4214.6 4216.5 4230.6 4214.7 4218.4 4232.3 4239.7 4246.6 3745.5 3750.7 3762.3 3779.4 3781.8 5159.6 5338.5 5340.0 5367.2 5433.5 4774.7 4832.1 4852.6 4878.9 4885.8 5453.9 5735.4 5739.4 5742.9 5762.7 4018.4 4029.7 4039.0 4041.6 4045.6 5962.8 6002.2 6011.6 6034.5 6043.8 3919.5 4197.3 4209.7 4210.7 4214.6 4134.4 4161.9 4184.7 4196.9 4200.3 4788.3 4816.7 4825.6 4835.7 4835.8 5510.6 5655.5 5711.6 5722.9 5723.7 1401.3 1431.8 1437.1 1437.8 1442.2 893.9 912.7 916.5 935.5 952.2 4792.6 4800.0 4809.5 4913.3 5000.2 4985.5 5060.9 5086.9 5089.3 5089.6 4853.7 4873.4 4948.4 4958.8 5300.3 3111.8 3129.4 3143.0 3167.4 3167.6 6106.0 6132.7 6142.4 6180.6 6185.6 5873.9 5903.7 5922.3 5926.3 5933.5 6003.3 6025.6 6037.3 6117.8 6126.3 5534.9 5800.7 5865.8 5882.5 5892.2 5747.2 5768.0 5781.8 5784.4 5786.7 6084.3 6092.4 6107.7 6123.4 6137.8 3883.1 3994.7 4048.0 4051.8 4061.3 5810.3 5818.7 5828.6 5841.2 5887.6 5491.4 5749.9 5762.6 5769.3 5778.2 5665.4 5684.6 5703.8 5719.1 5738.9 5708.2 5721.2 5728.0 5796.9 5825.9 5648.8 5690.5 5695.3 5777.4 5789.2 5633.4 5641.9 5642.7 5647.0 5655.2 16:17:47 INFO - PROCESS | 14827 | 16:17:47 INFO - PROCESS | 14827 | [#5] yui.html Cycles:180 Average:20912.92 Median:4656.43 stddev:31091.22 (667.7%) stddev-sans-first:31141.45 16:17:47 INFO - PROCESS | 14827 | Values: 714.9 740.2 765.4 796.5 820.8 14385.2 15416.5 15434.4 15547.8 15556.3 13652.7 13661.9 13772.7 13788.0 13813.7 790.6 799.4 811.2 816.2 816.3 800.5 805.5 807.3 807.3 808.2 845.3 847.2 849.0 850.6 851.0 840.4 847.8 847.8 848.2 849.3 629.3 629.4 629.4 629.8 630.3 13250.1 13420.3 13462.4 13541.5 13648.7 13027.2 13339.7 13355.9 13698.0 14063.3 12987.5 13344.1 13394.1 13472.5 13500.7 3796.9 3926.6 4488.2 4540.0 4589.8 64531.7 64670.0 66541.3 72914.0 75263.6 11343.4 11426.9 11483.1 11560.2 11563.8 20417.8 20464.4 20493.2 20514.5 20545.4 8139.3 8151.9 8175.0 8269.1 8388.5 4654.3 4699.3 4736.0 4748.8 4973.5 3666.7 3746.5 3774.1 3804.1 3812.3 651.2 675.6 675.7 689.6 695.5 699.9 725.0 742.0 743.2 745.3 9038.2 9243.3 9384.8 9624.5 9682.0 696.3 712.8 720.8 733.3 740.4 4658.6 4686.3 4749.8 4762.8 4776.3 121200.0 122785.4 122941.0 124496.2 127052.0 105080.9 106280.0 109500.0 112193.4 113793.0 77086.0 80423.0 93514.5 93773.0 93874.0 8575.1 8952.5 9053.3 9085.9 9164.2 48772.0 48882.3 50121.0 50162.0 50721.7 66046.0 71007.6 71583.6 73498.6 74425.0 12272.3 12605.9 12699.7 12703.2 12765.2 14182.6 14210.6 14314.7 14475.7 14647.1 13021.4 13023.3 13225.2 13509.9 13610.8 13642.7 13806.0 14500.6 14586.3 14587.7 12940.9 13035.2 13258.5 13312.3 13849.5 10791.5 10849.7 11064.8 11208.6 11250.8 11072.4 11111.9 11243.8 11373.4 11400.8 16:17:47 INFO - PROCESS | 14827 | -------- Summary: end -------- 16:17:47 INFO - PROCESS | 14827 | 16:17:48 INFO - TEST-INFO | 14827: exit 0 16:17:48 INFO - TEST-OK | dromaeo_css | took 1114946ms 16:17:48 INFO - TEST-START | kraken 16:17:48 INFO - operating with platform_type : linux_ 16:17:48 INFO - Initialising browser for kraken test... 16:17:48 INFO - TEST-INFO | started process 15192 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmvInkO/profile http://localhost:54668/getInfo.html) 16:17:53 INFO - PROCESS | 15192 | __metrics Screen width/height:1600/1200 16:17:53 INFO - PROCESS | 15192 | colorDepth:24 16:17:53 INFO - PROCESS | 15192 | Browser inner width/height: 1024/697 16:17:53 INFO - PROCESS | 15192 | __metrics 16:17:54 ERROR - PROCESS | 15192 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 16:17:54 INFO - TEST-INFO | 15192: exit 0 16:17:54 INFO - Browser initialized. 16:17:54 INFO - Running cycle 1/1 for kraken test... 16:17:54 INFO - TEST-INFO | started process 15318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmvInkO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:18:07 INFO - PROCESS | 15318 | RSS: Main: 182468608 16:18:07 INFO - PROCESS | 15318 | 16:18:09 INFO - PROCESS | 15318 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54668/tests/kraken/driver.html?testName=audio-beat-detection) 16:18:10 INFO - PROCESS | 15318 | RSS: Main: 196788224 16:18:10 INFO - PROCESS | 15318 | 16:18:13 INFO - PROCESS | 15318 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54668/tests/kraken/driver.html?testName=audio-dft) 16:18:14 INFO - PROCESS | 15318 | RSS: Main: 194576384 16:18:14 INFO - PROCESS | 15318 | 16:18:17 INFO - PROCESS | 15318 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54668/tests/kraken/driver.html?testName=audio-fft) 16:18:17 INFO - PROCESS | 15318 | RSS: Main: 191315968 16:18:17 INFO - PROCESS | 15318 | 16:18:19 INFO - PROCESS | 15318 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54668/tests/kraken/driver.html?testName=audio-oscillator) 16:18:20 INFO - PROCESS | 15318 | RSS: Main: 191766528 16:18:20 INFO - PROCESS | 15318 | 16:18:22 INFO - PROCESS | 15318 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54668/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:18:23 INFO - PROCESS | 15318 | RSS: Main: 191938560 16:18:23 INFO - PROCESS | 15318 | 16:18:26 INFO - PROCESS | 15318 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54668/tests/kraken/driver.html?testName=imaging-darkroom) 16:18:27 INFO - PROCESS | 15318 | RSS: Main: 191811584 16:18:27 INFO - PROCESS | 15318 | 16:18:30 INFO - PROCESS | 15318 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54668/tests/kraken/driver.html?testName=imaging-desaturate) 16:18:31 INFO - PROCESS | 15318 | RSS: Main: 192532480 16:18:31 INFO - PROCESS | 15318 | 16:18:33 INFO - PROCESS | 15318 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54668/tests/kraken/driver.html?testName=json-parse-financial) 16:18:34 INFO - PROCESS | 15318 | RSS: Main: 192442368 16:18:34 INFO - PROCESS | 15318 | 16:18:35 INFO - PROCESS | 15318 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54668/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:18:36 INFO - PROCESS | 15318 | RSS: Main: 192307200 16:18:36 INFO - PROCESS | 15318 | 16:18:38 INFO - PROCESS | 15318 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:18:38 INFO - PROCESS | 15318 | RSS: Main: 192495616 16:18:38 INFO - PROCESS | 15318 | 16:18:41 INFO - PROCESS | 15318 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:18:41 INFO - PROCESS | 15318 | RSS: Main: 192806912 16:18:41 INFO - PROCESS | 15318 | 16:18:44 INFO - PROCESS | 15318 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:18:45 INFO - PROCESS | 15318 | RSS: Main: 192466944 16:18:45 INFO - PROCESS | 15318 | 16:18:48 INFO - PROCESS | 15318 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:18:48 INFO - PROCESS | 15318 | RSS: Main: 192835584 16:18:48 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54668/tests/kraken/driver.html?testName=ai-astar) 16:18:50 INFO - PROCESS | 15318 | RSS: Main: 194269184 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | __start_tp_report 16:18:50 INFO - PROCESS | 15318 | _x_x_mozilla_page_load 16:18:50 INFO - PROCESS | 15318 | _x_x_mozilla_page_load_details 16:18:50 INFO - PROCESS | 15318 | |i|pagename|runs| 16:18:50 INFO - PROCESS | 15318 | |0;ai-astar;105;112;111;112;112;113;112;114;111;111 16:18:50 INFO - PROCESS | 15318 | |1;audio-beat-detection;163;129;125;182;130;126;124;129;162;124 16:18:50 INFO - PROCESS | 15318 | |2;audio-dft;163;166;166;169;168;162;165;165;164;163 16:18:50 INFO - PROCESS | 15318 | |3;audio-fft;75;76;77;114;78;76;77;85;118;77 16:18:50 INFO - PROCESS | 15318 | |4;audio-oscillator;84;82;118;83;84;83;99;84;84;116 16:18:50 INFO - PROCESS | 15318 | |5;imaging-gaussian-blur;118;119;119;118;119;117;118;118;117;117 16:18:50 INFO - PROCESS | 15318 | |6;imaging-darkroom;147;149;148;148;147;148;148;148;147;149 16:18:50 INFO - PROCESS | 15318 | |7;imaging-desaturate;87;86;85;86;85;85;84;86;86;86 16:18:50 INFO - PROCESS | 15318 | |8;json-parse-financial;53;55;53;55;55;53;56;54;56;56 16:18:50 INFO - PROCESS | 15318 | |9;json-stringify-tinderbox;61;61;64;61;60;60;61;64;63;61 16:18:50 INFO - PROCESS | 15318 | |10;stanford-crypto-aes;82;82;81;88;85;80;80;79;80;81 16:18:50 INFO - PROCESS | 15318 | |11;stanford-crypto-ccm;134;135;153;136;143;142;147;147;173;132 16:18:50 INFO - PROCESS | 15318 | |12;stanford-crypto-pbkdf2;172;176;171;170;167;166;169;172;165;171 16:18:50 INFO - PROCESS | 15318 | |13;stanford-crypto-sha256-iterative;76;66;67;66;71;69;65;66;65;70 16:18:50 INFO - PROCESS | 15318 | __end_tp_report 16:18:50 INFO - PROCESS | 15318 | __start_cc_report 16:18:50 INFO - PROCESS | 15318 | _x_x_mozilla_cycle_collect,820 16:18:50 INFO - PROCESS | 15318 | __end_cc_report 16:18:50 INFO - PROCESS | 15318 | __startTimestamp1476919130635__endTimestamp 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | ------- Summary: start ------- 16:18:50 INFO - PROCESS | 15318 | Number of tests: 14 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.41 (2.1%) stddev-sans-first:1.00 16:18:50 INFO - PROCESS | 15318 | Values: 105.0 112.0 111.0 112.0 112.0 113.0 112.0 114.0 111.0 111.0 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:129.50 stddev:21.21 (16.4%) stddev-sans-first:20.70 16:18:50 INFO - PROCESS | 15318 | Values: 163.0 129.0 125.0 182.0 130.0 126.0 124.0 129.0 162.0 124.0 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.50 stddev:2.23 (1.3%) stddev-sans-first:2.24 16:18:50 INFO - PROCESS | 15318 | Values: 163.0 166.0 166.0 169.0 168.0 162.0 165.0 165.0 164.0 163.0 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | [#3] audio-fft Cycles:10 Average:85.30 Median:77.00 stddev:16.44 (21.3%) stddev-sans-first:17.01 16:18:50 INFO - PROCESS | 15318 | Values: 75.0 76.0 77.0 114.0 78.0 76.0 77.0 85.0 118.0 77.0 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:84.00 stddev:14.21 (16.9%) stddev-sans-first:14.80 16:18:50 INFO - PROCESS | 15318 | Values: 84.0 82.0 118.0 83.0 84.0 83.0 99.0 84.0 84.0 116.0 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 16:18:50 INFO - PROCESS | 15318 | Values: 118.0 119.0 119.0 118.0 119.0 117.0 118.0 118.0 117.0 117.0 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 16:18:50 INFO - PROCESS | 15318 | Values: 147.0 149.0 148.0 148.0 147.0 148.0 148.0 148.0 147.0 149.0 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:0.84 (1.0%) stddev-sans-first:0.73 16:18:50 INFO - PROCESS | 15318 | Values: 87.0 86.0 85.0 86.0 85.0 85.0 84.0 86.0 86.0 86.0 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:1.26 (2.3%) stddev-sans-first:1.20 16:18:50 INFO - PROCESS | 15318 | Values: 53.0 55.0 53.0 55.0 55.0 53.0 56.0 54.0 56.0 56.0 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:61.00 stddev:1.51 (2.5%) stddev-sans-first:1.58 16:18:50 INFO - PROCESS | 15318 | Values: 61.0 61.0 64.0 61.0 60.0 60.0 61.0 64.0 63.0 61.0 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.50 stddev:2.74 (3.4%) stddev-sans-first:2.91 16:18:50 INFO - PROCESS | 15318 | Values: 82.0 82.0 81.0 88.0 85.0 80.0 80.0 79.0 80.0 81.0 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:145.00 stddev:12.17 (8.4%) stddev-sans-first:12.34 16:18:50 INFO - PROCESS | 15318 | Values: 134.0 135.0 153.0 136.0 143.0 142.0 147.0 147.0 173.0 132.0 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:171.00 stddev:3.28 (1.9%) stddev-sans-first:3.39 16:18:50 INFO - PROCESS | 15318 | Values: 172.0 176.0 171.0 170.0 167.0 166.0 169.0 172.0 165.0 171.0 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:3.48 (5.1%) stddev-sans-first:2.22 16:18:50 INFO - PROCESS | 15318 | Values: 76.0 66.0 67.0 66.0 71.0 69.0 65.0 66.0 65.0 70.0 16:18:50 INFO - PROCESS | 15318 | -------- Summary: end -------- 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | 16:18:50 INFO - PROCESS | 15318 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 16:18:50 INFO - PROCESS | 15318 | 16:18:51 INFO - TEST-INFO | 15318: exit 0 16:18:51 INFO - TEST-OK | kraken | took 62868ms 16:18:51 INFO - SUITE-END | took 1177s 16:18:51 INFO - Completed test suite (00:19:37) 16:18:51 INFO - javascript benchmark 16:18:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7176.778362522002, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.969280307197, 3088.675689052648, 3117.5947126873502, 3124.2814152744877, 3139.246580820604, 5123.462036486171, 5268.762905669249, 5339.385970613375, 5413.566914646829, 5427.728613569316, 5177.844664660057, 5230.084735171339, 5258.973705131479, 5279.340082489689, 5300.363956325236, 4801.0, 4845.563899249076, 4897.853064408074, 4905.23968784839, 4979.402471703383, 4803.495632958541, 4919.065377578267, 4976.900461990758, 4997.325361076245, 5015.774290156952, 4817.686850354751, 4855.854324370274, 4873.805047798084, 4911.361523002022, 4916.1888288432365, 4712.952870471286, 4787.736674482902, 4801.783919723621, 4828.106800241966, 4833.371661683958, 4684.250519916797, 4806.399200099988, 4806.927896081562, 4848.636352273594, 4858.757062146914, 5362.973185134088, 5388.946110538923, 5412.512873841373, 5415.6479828811, 5473.370562385337, 5624.437556244343, 5738.684372359518, 5769.88460230793, 5769.9711501442225, 5771.192033115325, 5715.199872017921, 5723.5421166307015, 5740.483356497935, 5744.827655170351, 5799.855003624901, 5290.100682883919, 5356.544693701079, 5362.758675859557, 5368.355797304271, 5370.167624018283, 5681.176229446707, 5713.857153571111, 5761.107028410603, 5829.621074630136, 5848.5884263918615, 5535.612507124462, 5555.2778138841695, 5556.055470570012, 5586.692731899784, 5615.101583746581, 5597.132444471114, 5599.7480113394995, 5612.915806262909, 5619.381867994599, 5621.578381621394, 5517.393086760453, 5557.916631250535, 5723.370429252779, 5752.050911599623, 5755.85610359736, 5795.33353664334, 5797.101449275369, 5804.477597016289, 5818.214541036906, 5819.476247137778, 4429.313456414261, 4442.644588432918, 4448.733076015449, 4450.465944086665, 4493.932591011137, 3841.769493830379, 3847.461355410245, 3848.1534062506203, 3853.3641949078087, 3986.402039694011, 5334.466553344712, 5366.543843773323, 5369.919451208235, 5400.324959380077, 5406.702631355313, 5568.136938774496, 5608.9439105609235, 5650.378458369576, 5651.350094739076, 5663.207150998864, 5369.570434365241, 5380.085385484477, 5394.029074766501, 5427.6472029317965, 5437.918431223535, 4923.286123512143, 4943.357363542788, 4955.950440495621, 4963.379577552806, 5022.0, 5914.408559144224, 5926.940730592639, 5939.13882487037, 5941.792037278588, 5968.612040217372, 5476.397596264328, 5799.82600521985, 5812.070068788974, 5835.299764028174, 5861.9706901465215, 5658.519025882846, 5835.387284335254, 5843.561732870136, 5917.082852157922, 5969.432903874125, 5562.276904002454, 5564.081926482085, 5565.1095824667855, 5565.1095824667855, 5565.805196818092, 5616.803411880564, 5663.688497132533, 5687.146927960839, 5694.1458781183155, 5696.458836410535, 5395.433479484597, 5430.429804870431, 5492.1212605982855, 5528.585356098229, 5570.275864137636, 5507.889842203053, 5530.308711411074, 5551.306086739158, 5562.360328562268, 5596.440355964371, 5390.245365648891, 5456.208849716848, 5486.972565137149, 5522.088855338824, 5532.972335138298, 5557.110862262019, 5612.915806262828, 5641.9435805641415, 5650.971745141413, 5744.540436764965, 5624.465675760796, 5625.409332020079, 5630.4369563043365, 5632.549396048388, 5639.54883609302], "value": 5259.970116279292, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.3762954305948, 587.8941790477712, 592.7865968251429, 596.4482853360643, 601.029337619744, 41312.58687413125, 43154.784226078904, 43175.13649727003, 46751.0, 47003.764981175045, 44376.11247775042, 44724.776376118076, 44817.0, 44824.55175448245, 44835.32747008789, 8844.823103537909, 9006.729798106067, 9013.459192448474, 9013.54932253388, 9014.54927253638, 8877.422967507091, 8931.55342232889, 8960.507172105532, 8962.283017358595, 8965.865512017324, 8974.955125224365, 8977.236934860544, 8989.775255618597, 9002.954985225064, 9004.909950900472, 8889.77775555613, 8917.152870477294, 8922.375433719642, 8949.105089491064, 8952.68665596701, 8767.78080547985, 8837.160469755363, 8854.911450885473, 8874.733757987271, 8875.423097498706, 41580.37629435561, 41760.164796703895, 41915.0, 41948.79025604852, 42070.579294206975, 3445.3798316303055, 3509.5613048368955, 3676.7242456815848, 3759.8496060157563, 3965.6629186518894, 30809.0, 30814.845925770453, 30951.69048309533, 31002.379952400825, 32901.3419731604, 3773.981130094332, 3810.4093865450623, 3817.9809100954317, 3944.5463771666336, 3992.480977472939, 320972.0, 322958.3852080748, 323241.0, 323733.0, 324774.0, 50472.0, 56946.71526642423, 57025.71487142621, 57238.0, 57251.99999999916, 59900.70049649724, 60073.699631501564, 60092.399076009555, 60311.69844150751, 60424.0, 15290.694186116438, 15545.922270388803, 15551.377944882304, 15577.0, 15635.3745850167, 11953.46209420578, 12027.699307517207, 12032.458539365574, 12035.217710848767, 12081.57714479989, 16368.83631163697, 16711.331546737994, 16937.661246774995, 17031.659366812593, 17189.656206876043, 3105.3634005029367, 5983.640981541034, 6118.5716999810475, 6227.419233940503, 6307.842303942438, 934.495372498843, 941.6939494664261, 974.5565767575736, 994.0953732103751, 1108.6673997800629, 31314.373712525623, 31391.21521961969, 31462.34776003064, 31662.208444789063, 31683.84158079241, 1058.6241884131023, 1071.8338657508098, 1073.5544748929108, 1081.6754973507916, 1124.1793490751797, 15340.539783806504, 16466.0, 16485.0, 16526.182119966794, 16695.66608667844, 520402.0, 522429.0, 524382.0, 526717.0, 530816.0, 57779.71110144423, 57885.0, 58046.7097664509, 58458.707706461195, 58471.99999999915, 1259.1815320042047, 1296.9286689232183, 1311.252586025975, 1324.4635922451616, 1329.0364485747755, 29174.27064323409, 30333.393332132793, 30518.84740576283, 30778.38443231078, 31001.224969375948, 50895.2365714522, 51110.488895110575, 51496.74251628718, 51607.741961289954, 51846.481535185674, 433581.0, 433617.0, 433972.0, 435874.0, 436721.0, 26397.604035939094, 27156.0, 27279.86360068187, 27446.5883011751, 27755.306117347227, 44884.551154489345, 45344.54655453535, 50577.0, 50734.49265507298, 52221.7388913053, 40100.0, 40596.39105413362, 40723.38914916219, 40897.0, 43046.78476607597, 39693.04604309377, 41552.0, 41625.167496649294, 41804.58195418007, 41937.0, 38422.0, 39741.60258397495, 40357.39463907985, 40409.1918161641, 40602.39096413497, 33231.667683322856, 35883.641163589076, 37239.94486657043, 37641.43537846989, 37794.24411511699, 27607.58588621132, 27892.721072789012, 28062.0, 28140.85929570421, 28240.43519129647], "value": 19576.880275970965, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.89390970528245, 383.2794346628338, 391.6240409207162, 392.92730844793715, 418.3432011741565, 14409.639759006004, 17785.91107044466, 17894.194761235743, 19495.122719477622, 19527.023648817554, 17466.388676396327, 17762.0, 18559.164837582306, 18697.34559290425, 18749.156287967042, 5167.767450464738, 5327.920081198785, 5580.274564306635, 5863.618864773776, 5955.7790652916265, 5900.262467191601, 5921.851953701149, 5931.288245410557, 5936.64380137191, 5947.464728174464, 5679.829605111853, 5772.769089236425, 5803.390643982384, 5816.360200377955, 5852.239208902836, 5664.235328230678, 5866.73599688015, 5877.823665290048, 5904.110684580935, 5912.940870591282, 5603.495685388294, 5648.293963254593, 5651.9152212716845, 5657.179708942222, 5669.0646043402785, 13714.65713357164, 13970.92639619282, 20799.896000520053, 21796.45508862275, 22001.66997495039, 2261.5476904618977, 2294.7705229477087, 2300.5973954558053, 2830.5754136879427, 2933.3399985003416, 9733.415995040321, 9815.656452024215, 10036.89963100367, 10171.440570768606, 10375.325603835801, 1846.6214426042764, 1934.9129289182022, 1944.854135939796, 1952.306931039489, 1978.4163671716735, 73134.0, 74425.25574744238, 79742.60128699377, 81342.18657813405, 83712.16287837105, 10541.84187237192, 10721.83917241242, 10802.621908233174, 11008.724781880517, 11130.276532025393, 13211.471541138248, 15094.16982065975, 15174.924125379302, 15226.0, 15256.313465894062, 6703.798886033427, 7594.430417718693, 7802.180771019075, 7840.098388685375, 7971.720989765447, 7157.89263161053, 7176.7846964591145, 7253.782386528413, 7412.073490813648, 7522.6614802334025, 4633.868420526595, 4634.675572709878, 4709.105269998689, 4737.881552961204, 4773.212419950739, 1946.1294590479213, 1958.3048017953422, 1973.8026197380148, 1979.7129416234566, 2005.8295044921344, 861.1345597674423, 887.2059506741431, 942.072059021863, 947.6777895515557, 1023.6775415744165, 18071.909640451977, 18609.44171674852, 18769.7184542232, 18955.052247387575, 19144.042797860053, 918.3066784577601, 929.5491686532026, 942.2556180617372, 993.7863359377768, 1013.5135135135029, 10119.949400252952, 10508.842367364496, 10658.467076646291, 10730.19523535738, 10817.134629229642, 427755.0, 442867.0, 445503.0, 446099.0, 446731.0, 79757.0, 87180.0, 88034.0, 88328.55835720908, 88857.0, 982.1700662939804, 983.8524221366853, 993.3245393132739, 1000.2248257600418, 1047.2930771729204, 16523.752143717615, 16795.664086718443, 17258.568535786704, 17531.912340438215, 17639.0, 36460.45309320415, 42884.14231715286, 43144.78427607842, 43387.78306108449, 44340.33489497725, 48903.0, 53610.19584706311, 54544.0, 54964.17553736777, 55179.0, 8239.629216685384, 8365.832683346178, 8395.118512556093, 8498.490090594583, 8605.65577376898, 12129.454174562343, 12853.228806271654, 13076.738465230832, 13205.471781129032, 13438.0, 11304.265222760494, 11392.829107563228, 11423.314601123959, 11503.252288601214, 11507.884921150682, 11264.66206013821, 11480.598179063692, 11646.0, 11663.825042624198, 11762.647120586396, 6482.157319548617, 8203.507789532408, 11333.603323883624, 11368.679901637324, 11615.6515304541, 7074.610896400747, 7354.595497247703, 7519.586422746802, 8062.395320351115, 8376.958115209629, 8478.448900821428, 10322.638707645196, 10968.23222374458, 11124.499397526968, 11525.942370288094], "value": 8881.8380364419, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.2052781234227, 1489.9627509312265, 1641.4419097506845, 1780.0120932882246, 1805.38616870264, 8007.879881801763, 8292.792680182984, 8580.74257772267, 9163.862542061874, 9174.082591740831, 8654.22112009919, 8846.601902914368, 8861.113888611135, 9131.132542408477, 9162.541872906362, 2315.224399826056, 2339.064374250305, 2339.7660233976635, 2342.0397636968846, 2348.2602980061224, 2283.6117859963765, 2285.8514196577253, 2353.035255545227, 2360.5160942006846, 2363.196513185517, 2303.3550605830396, 2309.064828744353, 2310.5378924215142, 2349.8472599281076, 2364.8344615876895, 2219.4007617943143, 2254.5378197469645, 2262.2760716570706, 2263.6944012558342, 2323.61660326046, 2239.3505883293824, 2241.955160896789, 2249.5051088760447, 2251.279590531031, 2266.478709896733, 9223.67717129904, 9224.677136300264, 9254.0, 9267.582958766872, 9295.442273463614, 5360.946390536123, 5480.205370221335, 5505.421930697299, 5511.58663100269, 5550.306211723535, 3295.489199174132, 3344.528407500716, 3455.188030812757, 3466.5146879436898, 3475.409180439306, 1023.6826583759058, 1051.2273478992934, 1059.8463222832722, 1070.7055559721139, 1094.0919037199105, 12993.480260789556, 13040.347982600926, 13059.020573457028, 13068.803967940583, 13070.477180912752, 4550.294704320836, 4637.118947399983, 4795.736234507136, 4855.393075865517, 4859.902801944012, 10885.455727213608, 10903.0, 10916.290441121302, 10919.39943303126, 10920.945395273131, 5397.946020539823, 5402.756875940592, 5440.3743569489225, 5450.700211488406, 5456.699881506555, 4312.159128969884, 4458.353538736865, 4811.975940120277, 4884.511548845158, 4970.527799859007, 3831.233753249361, 3897.279003384326, 3951.4665520154986, 3953.0710283083454, 3958.9010274743364, 1220.7436438348047, 1244.3778110944527, 1254.0782524844233, 1279.0918447902093, 1283.5315109984788, 785.6032703484703, 958.2094771813282, 977.3842479238034, 984.3650845204803, 1006.411249419098, 5805.767769289266, 5869.216588480374, 5957.493613042853, 6155.753769849156, 6220.253569571681, 411.66449343784717, 419.29976938512755, 419.40653974625565, 425.07546087260084, 426.3242760225016, 4151.522574903925, 4194.664426845845, 4223.070924396628, 4240.639545638655, 4269.4449721536, 11176.552937882394, 11418.0, 11520.423978801027, 11522.711932201595, 11538.307701537935, 11440.542378304775, 11446.828297575543, 11448.484818183202, 11475.483603237873, 11529.48117334722, 8125.75622731319, 8491.74524764258, 8496.787580310418, 8535.871961920577, 8539.615717292736, 6063.636181829104, 6278.215223097113, 6345.1116843641, 6347.809565713036, 6349.0476428536085, 10110.0, 10352.948235258775, 10506.842397364198, 10522.631707890187, 10531.684049478528, 10675.733106672395, 10677.51951162184, 10688.465576720977, 10714.196435267542, 10719.874413186502, 7183.820404489929, 7409.62951852416, 7447.32974032318, 8038.83922321562, 8084.595770211348, 8085.393595480245, 8358.498490090615, 8463.36524760633, 8464.619092140745, 8474.110218426977, 7478.4765066447, 7488.925110748823, 7552.886706699294, 7604.543727376154, 7737.6518056686455, 7262.709491620276, 7556.622168891643, 7635.656395462106, 7682.577458239851, 7704.036995375578, 7176.067111275501, 7222.241664625349, 7281.854362912818, 7306.013688152031, 7308.086489188851, 5093.541581257705, 5130.743462826918, 5143.202803565453, 5227.111391063604, 5330.493603107699, 5037.4887533739, 5167.302414174189, 5175.896482070262, 5183.844484665466, 5256.894862102813], "value": 4595.511824313097, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.800483700106, 331.1621597358682, 333.1371747174817, 337.12852276864305, 337.95606571145754, 5460.590455715817, 5483.122700367942, 5556.833295001152, 5600.747966341514, 5610.747516361764, 5395.757190926408, 5434.538064264532, 5444.945550544493, 5465.180222966547, 5498.615096943216, 4270.508891477481, 4297.763623000734, 4304.160688665712, 4307.741535507864, 4328.610425061744, 4124.216398884218, 4250.149970005996, 4322.82708691652, 4330.501992270898, 4351.347297905324, 4194.559571245021, 4212.304969679999, 4214.578542145776, 4216.536181020086, 4230.555791641864, 4214.704970652071, 4218.409422680827, 4232.343986682069, 4239.660827133822, 4246.639035681971, 3745.4756334113245, 3750.6999440044733, 3762.3415902217275, 3779.433085037266, 3781.810909454544, 5159.58723302135, 5338.466153384669, 5339.982909656071, 5367.1680889462195, 5433.483819037185, 4774.73738944358, 4832.106060378841, 4852.587530059949, 4878.902421951541, 4885.804567817283, 5453.863653408657, 5735.369109397963, 5739.3973632768375, 5742.908847318996, 5762.74067666956, 4018.3972404139613, 4029.677625789959, 4038.9798051009852, 4041.5756345583877, 4045.554988951213, 5962.821115366546, 6002.2197114375285, 6011.609245399035, 6034.456898879078, 6043.788467403664, 3919.510061242345, 4197.328427451593, 4209.726367786084, 4210.736778966298, 4214.578542145822, 4134.37984302357, 4161.875143745692, 4184.681825225044, 4196.853110141131, 4200.285951388271, 4788.3056956741775, 4816.735079570657, 4825.638077144228, 4835.709857408567, 4835.782389792468, 5510.614257001971, 5655.4910058094965, 5711.571632127607, 5722.939741692987, 5723.713814309268, 1401.3343661760787, 1431.7923901034292, 1437.0802686280788, 1437.8001657464097, 1442.235615123986, 893.9016708162097, 912.6811757011188, 916.5279880861361, 935.4667839331515, 952.1573407534244, 4792.592629626451, 4799.976000120047, 4809.519048095162, 4913.329467980903, 5000.174971129795, 4985.501449854985, 5060.861306206074, 5086.906315142262, 5089.287499750038, 5089.567386772092, 4853.699484350675, 4873.366462359871, 4948.4309304429735, 4958.752062396866, 5300.257963885059, 3111.782175247756, 3129.3741251749284, 3142.9528557071662, 3167.445697003015, 3167.6040494938134, 6105.992511235597, 6132.7121304526545, 6142.3550527194, 6180.567360284737, 6185.597936134227, 5873.911891321633, 5903.7048147593305, 5922.318933322636, 5926.259217597801, 5933.465988061095, 6003.309619393738, 6025.614108755011, 6037.275526936708, 6117.755289788448, 6126.264848218242, 5534.944650553443, 5800.651960882361, 5865.765369385347, 5882.499987500939, 5892.234009578899, 5747.166660834072, 5768.0, 5781.82654520365, 5784.421557844182, 5786.681732504752, 6084.300305464928, 6092.390760923872, 6107.725152368065, 6123.387661233841, 6137.84655383619, 3883.087474443447, 3994.7403418777685, 4048.0, 4051.8379264829077, 4061.2892743770312, 5810.302763668386, 5818.73815678304, 5828.6211396259105, 5841.153032810304, 5887.558433117619, 5491.395946445808, 5749.8562535936935, 5762.567807414377, 5769.336526299361, 5778.248827652378, 5665.376808551138, 5684.602077854511, 5703.771849126155, 5719.142128680731, 5738.913916291175, 5708.172315014217, 5721.1990321354215, 5727.971360143172, 5796.855078623068, 5825.883482330414, 5648.830535083954, 5690.5163061140265, 5695.288088988877, 5777.422257774189, 5789.163309978165, 5633.436656334334, 5641.887162256649, 5642.717864106696, 5646.971765141148, 5655.208270842003], "value": 4307.456176950302, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.8562300319493, 740.2116745665866, 765.3647472597744, 796.5021861336664, 820.7619790260825, 14385.208813515252, 15416.460423885166, 15434.382624695012, 15547.844521554782, 15556.299966501507, 13652.726945461085, 13661.863381366184, 13772.655683607914, 13788.034837561374, 13813.723725525484, 790.6165509727763, 799.436397339874, 811.1766556944706, 816.1593558634615, 816.2572059425923, 800.5236884053978, 805.5327909812295, 807.3097501636105, 807.3460496997421, 808.1635507249997, 845.3237410071948, 847.2205570874779, 849.0024221539666, 850.6384786465758, 850.9703259056519, 840.4201101240125, 847.8092429203441, 847.821957388949, 848.1687945813076, 849.2526576612603, 629.3046183966696, 629.3580547841223, 629.4272212286797, 629.8173529676388, 630.3035146163469, 13250.138740981805, 13420.32898355088, 13462.394192261372, 13541.526046588322, 13648.658783530393, 13027.218366898016, 13339.666508337272, 13355.933220333933, 13698.0, 14063.2968351582, 12987.545435909793, 13344.132631378929, 13394.129381590166, 13472.461101555926, 13500.662483437894, 3796.8671096511766, 3926.5877082906454, 4488.169688607585, 4539.977300113478, 4589.79345929434, 64531.677341612994, 64670.0, 66541.334586654, 72914.0, 75263.62368188179, 11343.432828358715, 11426.88573114275, 11483.08207038024, 11560.190786645022, 11563.750217429151, 20417.79582204159, 20464.38606841797, 20493.180272788923, 20514.487137821674, 20545.383638490868, 8139.348852091818, 8151.91158395495, 8175.0, 8269.131741167092, 8388.496690198608, 4654.27858681898, 4699.342092107107, 4735.952640473552, 4748.810047598057, 4973.502649734997, 3666.7249956253386, 3746.494223279822, 3774.0753515388906, 3804.1250512381753, 3812.275667623143, 651.2120334395435, 675.5811396933834, 675.6655455549436, 689.6034780001519, 695.4575431163701, 699.9020137180798, 724.9601271929989, 741.9554826710307, 743.1862110988459, 745.2770812312049, 9038.231750301298, 9243.26053915685, 9384.828655328085, 9624.51877406127, 9681.983391743766, 696.3384784454788, 712.8289210589525, 720.7657511308846, 733.2923728601925, 740.3521918321469, 4658.58072773452, 4686.27362758773, 4749.833755818529, 4762.809487620526, 4776.331313616097, 121200.0, 122785.38607306906, 122941.0, 124496.15271159992, 127052.0, 105080.86489188852, 106280.0, 109500.0, 112193.43903280431, 113793.0, 77085.99999999888, 80423.0, 93514.53242733743, 93773.0, 93874.0, 8575.099614540633, 8952.507612081137, 9053.321000924825, 9085.90914090877, 9164.175224229852, 48772.0, 48882.26676599925, 50121.0, 50162.0, 50721.74639126781, 66046.0, 71007.64496177486, 71583.64208178926, 73498.63250683712, 74425.0, 12272.325022123512, 12605.873941260837, 12699.746005080031, 12703.174293670882, 12765.170263932814, 14182.645433864236, 14210.573682789533, 14314.713705726035, 14475.710485790436, 14647.12117272967, 13021.414036368576, 13023.283719395145, 13225.206487610774, 13509.864901351253, 13610.795838062635, 13642.658933526742, 13806.0, 14500.564983050524, 14586.270686465847, 14587.708245835236, 12940.935295323463, 13035.15271507349, 13258.469661213443, 13312.267825269315, 13849.515266965607, 10791.514381852992, 10849.67450976472, 11064.834027489433, 11208.607698730506, 11250.831237531607, 11072.446377680923, 11111.944440277746, 11243.831342530033, 11373.431328433711, 11400.771984560428], "value": 7546.566622536239, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 111.0, 112.0, 112.0, 113.0, 112.0, 114.0, 111.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 129.0, 125.0, 182.0, 130.0, 126.0, 124.0, 129.0, 162.0, 124.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 166.0, 169.0, 168.0, 162.0, 165.0, 165.0, 164.0, 163.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 114.0, 78.0, 76.0, 77.0, 85.0, 118.0, 77.0], "value": 85.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 118.0, 83.0, 84.0, 83.0, 99.0, 84.0, 84.0, 116.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 119.0, 118.0, 119.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 149.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 85.0, 86.0, 85.0, 85.0, 84.0, 86.0, 86.0, 86.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 53.0, 55.0, 55.0, 53.0, 56.0, 54.0, 56.0, 56.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 64.0, 61.0, 60.0, 60.0, 61.0, 64.0, 63.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 88.0, 85.0, 80.0, 80.0, 79.0, 80.0, 81.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 153.0, 136.0, 143.0, 142.0, 147.0, 147.0, 173.0, 132.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 176.0, 171.0, 170.0, 167.0, 166.0, 169.0, 172.0, 165.0, 171.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 66.0, 67.0, 66.0, 71.0, 69.0, 65.0, 66.0, 65.0, 70.0], "value": 68.1, "unit": "score"}]}]} 16:18:51 INFO - Return code: 0 16:18:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:18:51 ERROR - # TBPL SUCCESS # 16:18:51 INFO - Running post-action listener: _resource_record_post_action 16:18:51 INFO - [mozharness: 2016-10-19 23:18:51.952786Z] Finished run-tests step (success) 16:18:51 INFO - Running post-run listener: _resource_record_post_run 16:18:52 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 393228288; Read time: 0; Write time: 281080 16:18:52 INFO - TinderboxPrint: CPU usage
13.4% 16:18:52 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:18:52 INFO - TinderboxPrint: I/O write bytes / time
393,228,288 / 281,080 16:18:52 INFO - TinderboxPrint: CPU idle
8,250.3 (86.6%) 16:18:52 INFO - TinderboxPrint: CPU user
1,217.3 (12.8%) 16:18:52 INFO - TinderboxPrint: Swap in / out
0 / 0 16:18:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 105316352; Read time: 0; Write time: 65792 16:18:52 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 287571968; Read time: 0; Write time: 215288 16:18:52 INFO - Running post-run listener: _upload_blobber_files 16:18:52 INFO - Blob upload gear active. 16:18:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:18:52 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:18:52 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:18:52 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:18:53 INFO - (blobuploader) - INFO - Open directory for files ... 16:18:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:18:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:18:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:18:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:18:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:18:56 INFO - (blobuploader) - INFO - Done attempting. 16:18:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:18:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:18:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:18:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:18:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:18:57 INFO - (blobuploader) - INFO - Done attempting. 16:18:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:18:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:18:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:18:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:18:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:18:57 INFO - (blobuploader) - INFO - Done attempting. 16:18:57 INFO - (blobuploader) - INFO - Iteration through files over. 16:18:57 INFO - Return code: 0 16:18:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:18:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:18:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9443aff2298dec2b30f698eb6676f7348809d0703d6a0809e4549bfb9de5eff012b5452774f04b1096ae2a8c5b2c51c9932d4b7361db688d7f9a98f94d5bcae7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e821de5d90b6cff088ec273212a77357ffedba78ed8794c69de2d1b5a05709df487338b2df8db2fc28d7cc1719dbc6faf0b2786d8978d2ae8d1ac589e8938c84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/018092bd6ee4d51d12ed2feb044c585ce9b895daef1753dbbbdf5d6ea333cc5615e12d68f88ace6e73438bfca2338df9575b233be6cf1840b324ed160bbf301f"} 16:18:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:18:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:18:57 INFO - Contents: 16:18:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9443aff2298dec2b30f698eb6676f7348809d0703d6a0809e4549bfb9de5eff012b5452774f04b1096ae2a8c5b2c51c9932d4b7361db688d7f9a98f94d5bcae7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e821de5d90b6cff088ec273212a77357ffedba78ed8794c69de2d1b5a05709df487338b2df8db2fc28d7cc1719dbc6faf0b2786d8978d2ae8d1ac589e8938c84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/018092bd6ee4d51d12ed2feb044c585ce9b895daef1753dbbbdf5d6ea333cc5615e12d68f88ace6e73438bfca2338df9575b233be6cf1840b324ed160bbf301f"} 16:18:57 INFO - Running post-run listener: copy_logs_to_upload_dir 16:18:57 INFO - Copying logs to upload dir... 16:18:57 INFO - mkdir: /builds/slave/test/build/upload/logs 16:18:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.094938 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-19 16:18:57.562580) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 16:18:57.566200) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065 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/Autoland/sha512/9443aff2298dec2b30f698eb6676f7348809d0703d6a0809e4549bfb9de5eff012b5452774f04b1096ae2a8c5b2c51c9932d4b7361db688d7f9a98f94d5bcae7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e821de5d90b6cff088ec273212a77357ffedba78ed8794c69de2d1b5a05709df487338b2df8db2fc28d7cc1719dbc6faf0b2786d8978d2ae8d1ac589e8938c84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/018092bd6ee4d51d12ed2feb044c585ce9b895daef1753dbbbdf5d6ea333cc5615e12d68f88ace6e73438bfca2338df9575b233be6cf1840b324ed160bbf301f"} build_url:https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011398 build_url: 'https://queue.taskcluster.net/v1/task/Ha-J9-qvS62LBI7D7LwUcA/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/Autoland/sha512/9443aff2298dec2b30f698eb6676f7348809d0703d6a0809e4549bfb9de5eff012b5452774f04b1096ae2a8c5b2c51c9932d4b7361db688d7f9a98f94d5bcae7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e821de5d90b6cff088ec273212a77357ffedba78ed8794c69de2d1b5a05709df487338b2df8db2fc28d7cc1719dbc6faf0b2786d8978d2ae8d1ac589e8938c84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/018092bd6ee4d51d12ed2feb044c585ce9b895daef1753dbbbdf5d6ea333cc5615e12d68f88ace6e73438bfca2338df9575b233be6cf1840b324ed160bbf301f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 16:18:57.592512) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 16:18:57.592894) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1476917897.180261-2119520065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 16:18:57.677939) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 16:18:57.678291) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 16:18:57.678645) ========= ========= Total master_lag: 0.18 =========