builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-069 starttime: 1475150479.3 results: success (0) buildid: 20160929033005 builduid: 271d871d628044ec9433ed359ca106e7 revision: dc21ccd6a304df32cdec43a71f01bdf80288ee98 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 05:01:19.301556) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 05:01:19.302068) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 05:01:19.302387) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 05:01:19.317688) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 05:01:19.318166) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-29 05:01:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.4M=0s 2016-09-29 05:01:20 (50.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.307115 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 05:01:19.639543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 05:01:19.639930) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021157 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 05:01:19.689455) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 05:01:19.689928) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dc21ccd6a304df32cdec43a71f01bdf80288ee98 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev dc21ccd6a304df32cdec43a71f01bdf80288ee98 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-29 05:01:20,190 truncating revision to first 12 chars 2016-09-29 05:01:20,190 Setting DEBUG logging. 2016-09-29 05:01:20,190 attempt 1/10 2016-09-29 05:01:20,190 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dc21ccd6a304?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 05:01:21,100 unpacking tar archive at: fx-team-dc21ccd6a304/testing/mozharness/ program finished with exit code 0 elapsedTime=1.340524 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 05:01:21.047229) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 05:01:21.048025) ========= script_repo_revision: dc21ccd6a304df32cdec43a71f01bdf80288ee98 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 05:01:21.048964) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 05:01:21.049470) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 05:01:21.061290) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-09-29 05:01:21.061602) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:01:21 INFO - MultiFileLogger online at 20160929 05:01:21 in /builds/slave/test 05:01:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:01:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:01:21 INFO - {'append_to_log': False, 05:01:21 INFO - 'base_work_dir': '/builds/slave/test', 05:01:21 INFO - 'blob_upload_branch': 'Fx-Team', 05:01:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:01:21 INFO - 'branch': 'Fx-Team', 05:01:21 INFO - 'buildbot_json_path': 'buildprops.json', 05:01:21 INFO - 'config_files': ('talos/linux_config.py',), 05:01:21 INFO - 'default_actions': ('clobber', 05:01:21 INFO - 'read-buildbot-config', 05:01:21 INFO - 'download-and-extract', 05:01:21 INFO - 'populate-webroot', 05:01:21 INFO - 'create-virtualenv', 05:01:21 INFO - 'install', 05:01:21 INFO - 'run-tests'), 05:01:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:01:21 INFO - 'download_minidump_stackwalk': True, 05:01:21 INFO - 'download_symbols': 'ondemand', 05:01:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:01:21 INFO - 'tooltool.py': '/tools/tooltool.py', 05:01:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:01:21 INFO - '/tools/misc-python/virtualenv.py')}, 05:01:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:01:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:01:21 INFO - 'installer_path': 'installer.exe', 05:01:21 INFO - 'log_level': 'info', 05:01:21 INFO - 'log_name': 'talos', 05:01:21 INFO - 'log_to_console': True, 05:01:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:01:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:01:21 INFO - 'opt_config_files': (), 05:01:21 INFO - 'pip_index': False, 05:01:21 INFO - 'sps_profile': False, 05:01:21 INFO - 'sps_profile_interval': 0, 05:01:21 INFO - 'suite': 'dromaeojs-e10s', 05:01:21 INFO - 'system_bits': '32', 05:01:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:01:21 INFO - 'title': 'talos-linux64-ix-069', 05:01:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:01:21 INFO - 'use_talos_json': True, 05:01:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:01:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:01:21 INFO - 'work_dir': 'build'} 05:01:21 INFO - [mozharness: 2016-09-29 12:01:21.663767Z] Running clobber step. 05:01:21 INFO - Running pre-action listener: _resource_record_pre_action 05:01:21 INFO - Running main action method: clobber 05:01:21 INFO - rmtree: /builds/slave/test/build 05:01:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:01:22 INFO - Running post-action listener: _resource_record_post_action 05:01:22 INFO - [mozharness: 2016-09-29 12:01:22.123491Z] Finished clobber step (success) 05:01:22 INFO - [mozharness: 2016-09-29 12:01:22.123593Z] Running read-buildbot-config step. 05:01:22 INFO - Running pre-action listener: _resource_record_pre_action 05:01:22 INFO - Running main action method: read_buildbot_config 05:01:22 INFO - Using buildbot properties: 05:01:22 INFO - { 05:01:22 INFO - "project": "", 05:01:22 INFO - "product": "firefox", 05:01:22 INFO - "script_repo_revision": "production", 05:01:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:01:22 INFO - "repository": "", 05:01:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:01:22 INFO - "buildid": "20160929033005", 05:01:22 INFO - "pgo_build": "True", 05:01:22 INFO - "basedir": "/builds/slave/test", 05:01:22 INFO - "buildnumber": 807, 05:01:22 INFO - "slavename": "talos-linux64-ix-069", 05:01:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:01:22 INFO - "platform": "ubuntu64_hw", 05:01:22 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:01:22 INFO - "branch": "fx-team", 05:01:22 INFO - "repo_path": "integration/fx-team", 05:01:22 INFO - "revision": "dc21ccd6a304df32cdec43a71f01bdf80288ee98", 05:01:22 INFO - "stage_platform": "linux64-pgo", 05:01:22 INFO - "builduid": "271d871d628044ec9433ed359ca106e7", 05:01:22 INFO - "slavebuilddir": "test" 05:01:22 INFO - } 05:01:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:01:22 INFO - Running post-action listener: _resource_record_post_action 05:01:22 INFO - [mozharness: 2016-09-29 12:01:22.126033Z] Finished read-buildbot-config step (success) 05:01:22 INFO - [mozharness: 2016-09-29 12:01:22.126122Z] Running download-and-extract step. 05:01:22 INFO - Running pre-action listener: _resource_record_pre_action 05:01:22 INFO - Running main action method: download_and_extract 05:01:22 INFO - mkdir: /builds/slave/test/build/tests 05:01:22 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')]} 05:01:22 INFO - trying https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:01:22 INFO - Downloading https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/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 05:01:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/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 05:01:22 INFO - Downloaded 1361 bytes. 05:01:22 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:01:22 INFO - Using the following test package requirements: 05:01:22 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:01:22 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:01:22 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:01:22 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'jsshell-linux-x86_64.zip'], 05:01:22 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:01:22 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:01:22 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:01:22 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:01:22 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:01:22 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:01:22 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:01:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:01:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:01:22 INFO - Fetch https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:01:23 INFO - Http code: 200 05:01:23 INFO - Content-Encoding: None 05:01:23 INFO - Content-Type: application/zip 05:01:23 INFO - via: 1.1 b04a4cffa8fb4f524ff7edcab1b5ae31.cloudfront.net (CloudFront) 05:01:23 INFO - x-amz-cf-id: o2Q2I6XkNP4y7-9sURvYLlDFJQNZuK7dwSt7159TQzfvvElNrfHABg== 05:01:23 INFO - x-amz-version-id: 7QhR1RPQbhS007dzbxpiMqUTo_NM1N5R 05:01:23 INFO - x-cache: Hit from cloudfront 05:01:24 INFO - Expected file size: 21988956 05:01:24 INFO - Obtained file size: 21988956 05:01:28 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 05:01:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:01:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:01:28 INFO - Fetch https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:01:28 INFO - Http code: 200 05:01:28 INFO - Content-Encoding: None 05:01:28 INFO - Content-Type: application/zip 05:01:28 INFO - via: 1.1 6be093c16fa776bbd432bbe9bd03f6af.cloudfront.net (CloudFront) 05:01:28 INFO - x-amz-cf-id: FlZFlpwZSeLAjAfGswF48KLOaZEFG39yva4Yho1SzyUpGljMHVHutQ== 05:01:28 INFO - x-amz-version-id: 7QhR1RPQbhS007dzbxpiMqUTo_NM1N5R 05:01:28 INFO - x-cache: Hit from cloudfront 05:01:29 INFO - Expected file size: 21988956 05:01:29 INFO - Obtained file size: 21988956 05:01:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:01:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:01:33 INFO - Fetch https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:01:34 INFO - Http code: 200 05:01:34 INFO - Content-Encoding: None 05:01:34 INFO - Content-Type: application/zip 05:01:34 INFO - via: 1.1 11512f00e812993b9daa35c376d7cb20.cloudfront.net (CloudFront) 05:01:34 INFO - x-amz-cf-id: 5ymWGf4SeNf7O-JweOFUQbesfWtvTydO0DJWzI8TVUnS4S2jGwJaHQ== 05:01:34 INFO - x-amz-version-id: 92X4XRAb.hW7aznKtbpB.x_oAzXiPAv_ 05:01:34 INFO - x-cache: Hit from cloudfront 05:01:34 INFO - Expected file size: 14414067 05:01:34 INFO - Obtained file size: 14414067 05:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:35 INFO - trying https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:01:35 INFO - Downloading https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/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 05:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/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 05:01:36 INFO - Downloaded 59710862 bytes. 05:01:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:01:36 INFO - mkdir: /builds/slave/test/properties 05:01:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:01:36 INFO - Writing to file /builds/slave/test/properties/build_url 05:01:36 INFO - Contents: 05:01:36 INFO - build_url:https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:01:37 INFO - Running post-action listener: _resource_record_post_action 05:01:37 INFO - Running post-action listener: set_extra_try_arguments 05:01:37 INFO - [mozharness: 2016-09-29 12:01:37.244504Z] Finished download-and-extract step (success) 05:01:37 INFO - [mozharness: 2016-09-29 12:01:37.244731Z] Running populate-webroot step. 05:01:37 INFO - Running pre-action listener: _resource_record_pre_action 05:01:37 INFO - Running main action method: populate_webroot 05:01:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:01:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:01:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:01:37 INFO - '--tppagecycles', 05:01:37 INFO - '7'], 05:01:37 INFO - 'tests': ['tsvgm']}}, 05:01:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:01:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:01:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:01:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:01:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:01:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:01:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:37 INFO - 'talos_options': ['--disable-e10s'], 05:01:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:37 INFO - 'talos_options': ['--disable-e10s'], 05:01:37 INFO - 'tests': ['damp', 'tps']}, 05:01:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:37 INFO - 'tests': ['damp', 'tps']}, 05:01:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:01:37 INFO - 'tests': ['dromaeo_dom']}, 05:01:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:01:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:01:37 INFO - 'tests': ['basic_compositor_video']}, 05:01:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:01:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:01:37 INFO - 'tests': ['a11yr', 05:01:37 INFO - 'ts_paint', 05:01:37 INFO - 'tpaint', 05:01:37 INFO - 'sessionrestore', 05:01:37 INFO - 'sessionrestore_no_auto_restore', 05:01:37 INFO - 'tabpaint']}, 05:01:37 INFO - 'other-e10s': {'tests': ['a11yr', 05:01:37 INFO - 'ts_paint', 05:01:37 INFO - 'tpaint', 05:01:37 INFO - 'sessionrestore', 05:01:37 INFO - 'sessionrestore_no_auto_restore', 05:01:37 INFO - 'tabpaint']}, 05:01:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:01:37 INFO - 'ts_paint', 05:01:37 INFO - 'tpaint', 05:01:37 INFO - 'sessionrestore', 05:01:37 INFO - 'sessionrestore_no_auto_restore', 05:01:37 INFO - 'tabpaint']}, 05:01:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:01:37 INFO - 'ts_paint', 05:01:37 INFO - 'tpaint', 05:01:37 INFO - 'sessionrestore', 05:01:37 INFO - 'sessionrestore_no_auto_restore', 05:01:37 INFO - 'tabpaint']}, 05:01:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:01:37 INFO - 'tests': ['a11yr', 05:01:37 INFO - 'ts_paint', 05:01:37 INFO - 'tpaint', 05:01:37 INFO - 'sessionrestore', 05:01:37 INFO - 'sessionrestore_no_auto_restore', 05:01:37 INFO - 'tabpaint']}, 05:01:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:01:37 INFO - 'tests': ['a11yr', 05:01:37 INFO - 'ts_paint', 05:01:37 INFO - 'tpaint', 05:01:37 INFO - 'sessionrestore', 05:01:37 INFO - 'sessionrestore_no_auto_restore', 05:01:37 INFO - 'tabpaint']}, 05:01:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:01:37 INFO - 'tests': ['tsvgx', 05:01:37 INFO - 'tsvgr_opacity', 05:01:37 INFO - 'tart', 05:01:37 INFO - 'tscrollx', 05:01:37 INFO - 'cart']}, 05:01:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:01:37 INFO - 'tsvgr_opacity', 05:01:37 INFO - 'tart', 05:01:37 INFO - 'tscrollx', 05:01:37 INFO - 'cart']}, 05:01:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:37 INFO - 'talos_options': ['--disable-e10s'], 05:01:37 INFO - 'tests': ['tp5o']}, 05:01:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:37 INFO - 'tests': ['tp5o']}, 05:01:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:37 INFO - 'talos_options': ['--disable-e10s', 05:01:37 INFO - '--xperf_path', 05:01:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:37 INFO - 'tests': ['tp5n']}, 05:01:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:37 INFO - 'talos_options': ['--xperf_path', 05:01:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:37 INFO - 'tests': ['tp5n']}}, 05:01:37 INFO - 'talos.zip': {'path': '', 05:01:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:01:37 INFO - Running post-action listener: _resource_record_post_action 05:01:37 INFO - [mozharness: 2016-09-29 12:01:37.264573Z] Finished populate-webroot step (success) 05:01:37 INFO - [mozharness: 2016-09-29 12:01:37.264661Z] Running create-virtualenv step. 05:01:37 INFO - Running pre-action listener: _resource_record_pre_action 05:01:37 INFO - Running main action method: create_virtualenv 05:01:37 INFO - Creating virtualenv /builds/slave/test/build/venv 05:01:37 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 05:01:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:01:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:01:37 INFO - Using real prefix '/usr' 05:01:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:01:37 INFO - Installing distribute.............................................................................................................................................................................................done. 05:01:39 INFO - Installing pip.................done. 05:01:39 INFO - Return code: 0 05:01:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:01:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:01:40 INFO - Reading from file tmpfile_stdout 05:01:40 INFO - Output received: 05:01:40 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) 05:01:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e9b8adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700930>, '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 0x1701830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1701cc0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', '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 05:01: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', 'pip>=1.5'] in /builds/slave/test/build 05:01: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 pip>=1.5 05:01:40 INFO - Using env: {'DISPLAY': ':0', 05:01:40 INFO - 'HOME': '/home/cltbld', 05:01:40 INFO - 'LANG': 'en_US.UTF-8', 05:01:40 INFO - 'LANGUAGE': 'en_US:en', 05:01:40 INFO - 'LOGNAME': 'cltbld', 05:01:40 INFO - 'MAIL': '/var/mail/cltbld', 05:01:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:40 INFO - 'MOZ_NO_REMOTE': '1', 05:01:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:40 INFO - 'NO_EM_RESTART': '1', 05:01:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:40 INFO - 'PWD': '/builds/slave/test', 05:01:40 INFO - 'SHELL': '/bin/bash', 05:01:40 INFO - 'SHLVL': '1', 05:01:40 INFO - 'TERM': 'linux', 05:01:40 INFO - 'TMOUT': '86400', 05:01:40 INFO - 'USER': 'cltbld', 05:01:40 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', 05:01:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:40 INFO - '_': '/tools/buildbot/bin/python'} 05:01:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:40 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 05:01:40 INFO - Cleaning up... 05:01:40 INFO - Return code: 0 05:01:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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', '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 0x7f7e9b8adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700930>, '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 0x1701830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1701cc0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', '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 05:01: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:01: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 psutil>=3.1.1 05:01:40 INFO - Using env: {'DISPLAY': ':0', 05:01:40 INFO - 'HOME': '/home/cltbld', 05:01:40 INFO - 'LANG': 'en_US.UTF-8', 05:01:40 INFO - 'LANGUAGE': 'en_US:en', 05:01:40 INFO - 'LOGNAME': 'cltbld', 05:01:40 INFO - 'MAIL': '/var/mail/cltbld', 05:01:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:40 INFO - 'MOZ_NO_REMOTE': '1', 05:01:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:40 INFO - 'NO_EM_RESTART': '1', 05:01:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:40 INFO - 'PWD': '/builds/slave/test', 05:01:40 INFO - 'SHELL': '/bin/bash', 05:01:40 INFO - 'SHLVL': '1', 05:01:40 INFO - 'TERM': 'linux', 05:01:40 INFO - 'TMOUT': '86400', 05:01:40 INFO - 'USER': 'cltbld', 05:01:40 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', 05:01:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:40 INFO - '_': '/tools/buildbot/bin/python'} 05:01:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:40 INFO - Downloading/unpacking psutil>=3.1.1 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:01:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:01:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:01:42 INFO - Installing collected packages: psutil 05:01:42 INFO - Running setup.py install for psutil 05:01:42 INFO - building 'psutil._psutil_linux' extension 05:01:42 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 05:01:42 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 05:01:42 INFO - building 'psutil._psutil_posix' extension 05:01:42 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 05:01:42 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 05:01:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:01:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:01:42 INFO - Successfully installed psutil 05:01:42 INFO - Cleaning up... 05:01:43 INFO - Return code: 0 05:01:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:01:43 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')]} 05:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:43 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')]} 05:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:43 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 0x7f7e9b8adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700930>, '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 0x1701830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1701cc0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', '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 05:01:43 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 05:01:43 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 05:01:43 INFO - Using env: {'DISPLAY': ':0', 05:01:43 INFO - 'HOME': '/home/cltbld', 05:01:43 INFO - 'LANG': 'en_US.UTF-8', 05:01:43 INFO - 'LANGUAGE': 'en_US:en', 05:01:43 INFO - 'LOGNAME': 'cltbld', 05:01:43 INFO - 'MAIL': '/var/mail/cltbld', 05:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:43 INFO - 'MOZ_NO_REMOTE': '1', 05:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:43 INFO - 'NO_EM_RESTART': '1', 05:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:43 INFO - 'PWD': '/builds/slave/test', 05:01:43 INFO - 'SHELL': '/bin/bash', 05:01:43 INFO - 'SHLVL': '1', 05:01:43 INFO - 'TERM': 'linux', 05:01:43 INFO - 'TMOUT': '86400', 05:01:43 INFO - 'USER': 'cltbld', 05:01:43 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', 05:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:43 INFO - '_': '/tools/buildbot/bin/python'} 05:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:01:43 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 05:01:43 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 05:01:43 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 05:01:43 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 05:01:43 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 05:01:43 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 05:01:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:01:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:01:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:01:45 INFO - Installing collected packages: mozsystemmonitor 05:01:45 INFO - Running setup.py install for mozsystemmonitor 05:01:45 INFO - Successfully installed mozsystemmonitor 05:01:45 INFO - Cleaning up... 05:01:45 INFO - Return code: 0 05:01:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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', '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 0x7f7e9b8adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700930>, '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 0x1701830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1701cc0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', '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 05:01: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:01: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 jsonschema==2.5.1 05:01:45 INFO - Using env: {'DISPLAY': ':0', 05:01:45 INFO - 'HOME': '/home/cltbld', 05:01:45 INFO - 'LANG': 'en_US.UTF-8', 05:01:45 INFO - 'LANGUAGE': 'en_US:en', 05:01:45 INFO - 'LOGNAME': 'cltbld', 05:01:45 INFO - 'MAIL': '/var/mail/cltbld', 05:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:45 INFO - 'MOZ_NO_REMOTE': '1', 05:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:45 INFO - 'NO_EM_RESTART': '1', 05:01:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:45 INFO - 'PWD': '/builds/slave/test', 05:01:45 INFO - 'SHELL': '/bin/bash', 05:01:45 INFO - 'SHLVL': '1', 05:01:45 INFO - 'TERM': 'linux', 05:01:45 INFO - 'TMOUT': '86400', 05:01:45 INFO - 'USER': 'cltbld', 05:01:45 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', 05:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:45 INFO - '_': '/tools/buildbot/bin/python'} 05:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:45 INFO - Downloading/unpacking jsonschema==2.5.1 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:01:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:47 INFO - Downloading functools32-3.2.3-2.tar.gz 05:01:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:01:47 INFO - warning: no files found matching '*.txt' 05:01:47 INFO - no previously-included directories found matching 'build' 05:01:47 INFO - no previously-included directories found matching 'dist' 05:01:47 INFO - no previously-included directories found matching '.git*' 05:01:47 INFO - Installing collected packages: jsonschema, functools32 05:01:47 INFO - Running setup.py install for functools32 05:01:47 INFO - warning: no files found matching '*.txt' 05:01:47 INFO - no previously-included directories found matching 'build' 05:01:47 INFO - no previously-included directories found matching 'dist' 05:01:47 INFO - no previously-included directories found matching '.git*' 05:01:47 INFO - Successfully installed jsonschema functools32 05:01:47 INFO - Cleaning up... 05:01:47 INFO - Return code: 0 05:01:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:47 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 0x7f7e9b8adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700930>, '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 0x1701830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1701cc0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', '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 05:01:47 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 05:01:47 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 05:01:47 INFO - Using env: {'DISPLAY': ':0', 05:01:47 INFO - 'HOME': '/home/cltbld', 05:01:47 INFO - 'LANG': 'en_US.UTF-8', 05:01:47 INFO - 'LANGUAGE': 'en_US:en', 05:01:47 INFO - 'LOGNAME': 'cltbld', 05:01:47 INFO - 'MAIL': '/var/mail/cltbld', 05:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:47 INFO - 'MOZ_NO_REMOTE': '1', 05:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:47 INFO - 'NO_EM_RESTART': '1', 05:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:47 INFO - 'PWD': '/builds/slave/test', 05:01:47 INFO - 'SHELL': '/bin/bash', 05:01:47 INFO - 'SHLVL': '1', 05:01:47 INFO - 'TERM': 'linux', 05:01:47 INFO - 'TMOUT': '86400', 05:01:47 INFO - 'USER': 'cltbld', 05:01:47 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', 05:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:47 INFO - '_': '/tools/buildbot/bin/python'} 05:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:01:48 INFO - Cleaning up... 05:01:48 INFO - Return code: 0 05:01:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7e9b8adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700930>, '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 0x1701830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1701cc0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', '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 05:01:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:01:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:01:48 INFO - Using env: {'DISPLAY': ':0', 05:01:48 INFO - 'HOME': '/home/cltbld', 05:01:48 INFO - 'LANG': 'en_US.UTF-8', 05:01:48 INFO - 'LANGUAGE': 'en_US:en', 05:01:48 INFO - 'LOGNAME': 'cltbld', 05:01:48 INFO - 'MAIL': '/var/mail/cltbld', 05:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:48 INFO - 'MOZ_NO_REMOTE': '1', 05:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:48 INFO - 'NO_EM_RESTART': '1', 05:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:48 INFO - 'PWD': '/builds/slave/test', 05:01:48 INFO - 'SHELL': '/bin/bash', 05:01:48 INFO - 'SHLVL': '1', 05:01:48 INFO - 'TERM': 'linux', 05:01:48 INFO - 'TMOUT': '86400', 05:01:48 INFO - 'USER': 'cltbld', 05:01:48 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', 05:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:48 INFO - '_': '/tools/buildbot/bin/python'} 05:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:48 INFO - Downloading/unpacking blobuploader==1.2.4 05:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:50 INFO - Downloading blobuploader-1.2.4.tar.gz 05:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:01:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:01:50 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 05:01:50 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 05:01:50 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 05:01:50 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 05:01:50 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 05:01:50 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 05:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:01:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:01:50 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 05:01:50 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 05:01:50 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 05:01:50 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 05:01:50 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 05:01:50 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 05:01:50 INFO - Downloading docopt-0.6.1.tar.gz 05:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:01:50 INFO - Installing collected packages: blobuploader, requests, docopt 05:01:50 INFO - Running setup.py install for blobuploader 05:01:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:01:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:01:51 INFO - Running setup.py install for requests 05:01:51 INFO - Running setup.py install for docopt 05:01:51 INFO - Successfully installed blobuploader requests docopt 05:01:51 INFO - Cleaning up... 05:01:51 INFO - Return code: 0 05:01:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:51 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 0x7f7e9b8adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700930>, '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 0x1701830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1701cc0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', '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 05:01:51 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 05:01:51 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 05:01:51 INFO - Using env: {'DISPLAY': ':0', 05:01:51 INFO - 'HOME': '/home/cltbld', 05:01:51 INFO - 'LANG': 'en_US.UTF-8', 05:01:51 INFO - 'LANGUAGE': 'en_US:en', 05:01:51 INFO - 'LOGNAME': 'cltbld', 05:01:51 INFO - 'MAIL': '/var/mail/cltbld', 05:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:51 INFO - 'MOZ_NO_REMOTE': '1', 05:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:51 INFO - 'NO_EM_RESTART': '1', 05:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:51 INFO - 'PWD': '/builds/slave/test', 05:01:51 INFO - 'SHELL': '/bin/bash', 05:01:51 INFO - 'SHLVL': '1', 05:01:51 INFO - 'TERM': 'linux', 05:01:51 INFO - 'TMOUT': '86400', 05:01:51 INFO - 'USER': 'cltbld', 05:01:51 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', 05:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:51 INFO - '_': '/tools/buildbot/bin/python'} 05:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:01:51 INFO - Running setup.py (path:/tmp/pip-AL9JcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:01:51 INFO - Running setup.py (path:/tmp/pip-CaTz0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:01:51 INFO - Running setup.py (path:/tmp/pip-nYU_tP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:01:52 INFO - Running setup.py (path:/tmp/pip-0wWRhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:01:52 INFO - Running setup.py (path:/tmp/pip-ttdCxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:01:52 INFO - Running setup.py (path:/tmp/pip-meWTzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:01:52 INFO - Running setup.py (path:/tmp/pip-X7aRiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:01:52 INFO - Running setup.py (path:/tmp/pip-jVKZ1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:01:52 INFO - Running setup.py (path:/tmp/pip-efWGqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:01:52 INFO - Running setup.py (path:/tmp/pip-lLH7Bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:01:52 INFO - Running setup.py (path:/tmp/pip-QhlXn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:01:52 INFO - Running setup.py (path:/tmp/pip-fl6YPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:01:52 INFO - Running setup.py (path:/tmp/pip-P1I6S8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:01:52 INFO - Running setup.py (path:/tmp/pip-1g5uz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:52 INFO - Running setup.py (path:/tmp/pip-ZFUPHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:01:52 INFO - Running setup.py (path:/tmp/pip-7ePMyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:01:52 INFO - Running setup.py (path:/tmp/pip-WfVNvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:01:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:01:53 INFO - Running setup.py install for manifestparser 05:01:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:01:53 INFO - Running setup.py install for mozcrash 05:01:53 INFO - Running setup.py install for mozdebug 05:01:53 INFO - Running setup.py install for mozdevice 05:01:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:01:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:01:53 INFO - Running setup.py install for mozfile 05:01:53 INFO - Running setup.py install for mozhttpd 05:01:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:01:53 INFO - Running setup.py install for mozinfo 05:01:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:01:53 INFO - Running setup.py install for mozInstall 05:01:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:01:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:01:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:01:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:01:53 INFO - Running setup.py install for mozleak 05:01:53 INFO - Running setup.py install for mozlog 05:01:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:01:54 INFO - Running setup.py install for moznetwork 05:01:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:01:54 INFO - Running setup.py install for mozprocess 05:01:54 INFO - Running setup.py install for mozprofile 05:01:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:01:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:01:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:01:54 INFO - Running setup.py install for mozrunner 05:01:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:01:54 INFO - Running setup.py install for mozscreenshot 05:01:54 INFO - Running setup.py install for moztest 05:01:54 INFO - Running setup.py install for mozversion 05:01:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:01:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:01:54 INFO - Cleaning up... 05:01:54 INFO - Return code: 0 05:01:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:54 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 0x7f7e9b8adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700930>, '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 0x1701830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1701cc0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', '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 05:01:54 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 05:01:54 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 05:01:54 INFO - Using env: {'DISPLAY': ':0', 05:01:54 INFO - 'HOME': '/home/cltbld', 05:01:54 INFO - 'LANG': 'en_US.UTF-8', 05:01:54 INFO - 'LANGUAGE': 'en_US:en', 05:01:54 INFO - 'LOGNAME': 'cltbld', 05:01:54 INFO - 'MAIL': '/var/mail/cltbld', 05:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:54 INFO - 'MOZ_NO_REMOTE': '1', 05:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:54 INFO - 'NO_EM_RESTART': '1', 05:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:54 INFO - 'PWD': '/builds/slave/test', 05:01:54 INFO - 'SHELL': '/bin/bash', 05:01:54 INFO - 'SHLVL': '1', 05:01:54 INFO - 'TERM': 'linux', 05:01:54 INFO - 'TMOUT': '86400', 05:01:54 INFO - 'USER': 'cltbld', 05:01:54 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', 05:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:54 INFO - '_': '/tools/buildbot/bin/python'} 05:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:01:55 INFO - Running setup.py (path:/tmp/pip-wioA3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:01:55 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)) 05:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:01:55 INFO - Running setup.py (path:/tmp/pip-3nYiBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:01:55 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)) 05:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:01:55 INFO - Running setup.py (path:/tmp/pip-HW6j57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:01:55 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)) 05:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:01:55 INFO - Running setup.py (path:/tmp/pip-v41efR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:01:55 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)) 05:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:01:55 INFO - Running setup.py (path:/tmp/pip-NWKvX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:01:55 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)) 05:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:01:55 INFO - Running setup.py (path:/tmp/pip-8LBjuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:01:55 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)) 05:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:01:55 INFO - Running setup.py (path:/tmp/pip-JRcA1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:01:55 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)) 05:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:01:55 INFO - Running setup.py (path:/tmp/pip-JAlb3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:01:55 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)) 05:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:01:55 INFO - Running setup.py (path:/tmp/pip-NWaVGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:01:55 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)) 05:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:01:55 INFO - Running setup.py (path:/tmp/pip-J5elnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:01:55 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)) 05:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:01:55 INFO - Running setup.py (path:/tmp/pip-0qfXG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:01:55 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)) 05:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:01:55 INFO - Running setup.py (path:/tmp/pip-rxsxG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:01:55 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)) 05:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:01:55 INFO - Running setup.py (path:/tmp/pip-ggJNgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:01:56 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)) 05:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:01:56 INFO - Running setup.py (path:/tmp/pip-EyM7au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:01:56 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)) 05:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:56 INFO - Running setup.py (path:/tmp/pip-OgaaIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:56 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)) 05:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:01:56 INFO - Running setup.py (path:/tmp/pip-iLPGSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:01:56 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)) 05:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:01:56 INFO - Running setup.py (path:/tmp/pip-8BNUWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:01:56 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)) 05:01:56 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)) 05:01:56 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)) 05:01:56 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)) 05:01:56 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)) 05:01:56 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)) 05:01:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:58 INFO - Downloading blessings-1.6.tar.gz 05:01:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:01:58 INFO - Installing collected packages: blessings 05:01:58 INFO - Running setup.py install for blessings 05:01:58 INFO - Successfully installed blessings 05:01:58 INFO - Cleaning up... 05:01:58 INFO - Return code: 0 05:01:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:01:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:01:58 INFO - Reading from file tmpfile_stdout 05:01:58 INFO - Current package versions: 05:01:58 INFO - argparse == 1.2.1 05:01:58 INFO - blessings == 1.6 05:01:58 INFO - blobuploader == 1.2.4 05:01:58 INFO - docopt == 0.6.1 05:01:58 INFO - functools32 == 3.2.3-2 05:01:58 INFO - jsonschema == 2.5.1 05:01:58 INFO - manifestparser == 1.1 05:01:58 INFO - mozInstall == 1.12 05:01:58 INFO - mozcrash == 0.17 05:01:58 INFO - mozdebug == 0.1 05:01:58 INFO - mozdevice == 0.48 05:01:58 INFO - mozfile == 1.2 05:01:58 INFO - mozhttpd == 0.7 05:01:58 INFO - mozinfo == 0.9 05:01:58 INFO - mozleak == 0.1 05:01:58 INFO - mozlog == 3.4 05:01:58 INFO - moznetwork == 0.27 05:01:58 INFO - mozprocess == 0.23 05:01:58 INFO - mozprofile == 0.28 05:01:58 INFO - mozrunner == 6.12 05:01:58 INFO - mozscreenshot == 0.1 05:01:58 INFO - mozsystemmonitor == 0.3 05:01:58 INFO - moztest == 0.7 05:01:58 INFO - mozversion == 1.4 05:01:58 INFO - psutil == 3.1.1 05:01:58 INFO - requests == 1.2.3 05:01:58 INFO - wsgiref == 0.1.2 05:01:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:01:58 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')]} 05:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:58 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')]} 05:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:58 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 0x7f7e9b8adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700930>, '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 0x1701830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1701cc0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', '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 05:01:58 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 05:01:58 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 05:01:58 INFO - Using env: {'DISPLAY': ':0', 05:01:58 INFO - 'HOME': '/home/cltbld', 05:01:58 INFO - 'LANG': 'en_US.UTF-8', 05:01:58 INFO - 'LANGUAGE': 'en_US:en', 05:01:58 INFO - 'LOGNAME': 'cltbld', 05:01:58 INFO - 'MAIL': '/var/mail/cltbld', 05:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:58 INFO - 'MOZ_NO_REMOTE': '1', 05:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:58 INFO - 'NO_EM_RESTART': '1', 05:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:58 INFO - 'PWD': '/builds/slave/test', 05:01:58 INFO - 'SHELL': '/bin/bash', 05:01:58 INFO - 'SHLVL': '1', 05:01:58 INFO - 'TERM': 'linux', 05:01:58 INFO - 'TMOUT': '86400', 05:01:58 INFO - 'USER': 'cltbld', 05:01:58 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', 05:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:58 INFO - '_': '/tools/buildbot/bin/python'} 05:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:58 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)) 05:01:58 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)) 05:01:58 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)) 05:01:58 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)) 05:01:58 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)) 05:01:58 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)) 05:01:58 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)) 05:01:58 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)) 05:01:58 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)) 05:01:58 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)) 05:01:58 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)) 05:01:58 INFO - Cleaning up... 05:01:58 INFO - Return code: 0 05:01:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:01:58 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')]} 05:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:58 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')]} 05:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:58 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 0x7f7e9b8adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700930>, '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 0x1701830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1701cc0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', '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 05:01:58 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 05:01:58 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 05:01:58 INFO - Using env: {'DISPLAY': ':0', 05:01:58 INFO - 'HOME': '/home/cltbld', 05:01:58 INFO - 'LANG': 'en_US.UTF-8', 05:01:58 INFO - 'LANGUAGE': 'en_US:en', 05:01:58 INFO - 'LOGNAME': 'cltbld', 05:01:58 INFO - 'MAIL': '/var/mail/cltbld', 05:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:58 INFO - 'MOZ_NO_REMOTE': '1', 05:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:58 INFO - 'NO_EM_RESTART': '1', 05:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:58 INFO - 'PWD': '/builds/slave/test', 05:01:58 INFO - 'SHELL': '/bin/bash', 05:01:58 INFO - 'SHLVL': '1', 05:01:58 INFO - 'TERM': 'linux', 05:01:58 INFO - 'TMOUT': '86400', 05:01:58 INFO - 'USER': 'cltbld', 05:01:58 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', 05:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:58 INFO - '_': '/tools/buildbot/bin/python'} 05:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:01:59 INFO - Cleaning up... 05:01:59 INFO - Return code: 0 05:01:59 INFO - Running post-action listener: _resource_record_post_action 05:01:59 INFO - Running post-action listener: _start_resource_monitoring 05:01:59 INFO - Starting resource monitoring. 05:01:59 INFO - [mozharness: 2016-09-29 12:01:59.184180Z] Finished create-virtualenv step (success) 05:01:59 INFO - [mozharness: 2016-09-29 12:01:59.184697Z] Running install step. 05:01:59 INFO - Running pre-action listener: _resource_record_pre_action 05:01:59 INFO - Running main action method: install 05:01:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:01:59 INFO - Reading from file tmpfile_stdout 05:01:59 INFO - Detecting whether we're running mozinstall >=1.0... 05:01:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:01:59 INFO - Reading from file tmpfile_stdout 05:01:59 INFO - Output received: 05:01:59 INFO - Usage: mozinstall [options] installer 05:01:59 INFO - Options: 05:01:59 INFO - -h, --help show this help message and exit 05:01:59 INFO - -d DEST, --destination=DEST 05:01:59 INFO - Directory to install application into. [default: 05:01:59 INFO - "/builds/slave/test"] 05:01:59 INFO - --app=APP Application being installed. [default: firefox] 05:01:59 INFO - mkdir: /builds/slave/test/build/application 05:01:59 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'] 05:01:59 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 05:02:16 INFO - Reading from file tmpfile_stdout 05:02:16 INFO - Output received: 05:02:16 INFO - /builds/slave/test/build/application/firefox/firefox 05:02:16 INFO - Running post-action listener: _resource_record_post_action 05:02:16 INFO - [mozharness: 2016-09-29 12:02:16.481712Z] Finished install step (success) 05:02:16 INFO - [mozharness: 2016-09-29 12:02:16.482046Z] Running run-tests step. 05:02:16 INFO - Running pre-action listener: _resource_record_pre_action 05:02:16 INFO - Running main action method: run_tests 05:02:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:02:16 INFO - Python 2.7.3 05:02:16 INFO - Return code: 0 05:02:16 INFO - grabbing minidump binary from tooltool 05:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:16 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 0x1700930>, '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 0x1701830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1701cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:02:16 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 05:02:16 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 05:02:16 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 05:02:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:02:16 INFO - Return code: 0 05:02:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:02:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:02:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:02:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:02:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:02:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 05:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 05:02:16 INFO - Using env: {'DISPLAY': ':0', 05:02:16 INFO - 'HOME': '/home/cltbld', 05:02:16 INFO - 'LANG': 'en_US.UTF-8', 05:02:16 INFO - 'LANGUAGE': 'en_US:en', 05:02:16 INFO - 'LOGNAME': 'cltbld', 05:02:16 INFO - 'MAIL': '/var/mail/cltbld', 05:02:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:02:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:16 INFO - 'MOZ_NO_REMOTE': '1', 05:02:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:16 INFO - 'NO_EM_RESTART': '1', 05:02:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:16 INFO - 'PWD': '/builds/slave/test', 05:02:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:02:16 INFO - 'SHELL': '/bin/bash', 05:02:16 INFO - 'SHLVL': '1', 05:02:16 INFO - 'TERM': 'linux', 05:02:16 INFO - 'TMOUT': '86400', 05:02:16 INFO - 'USER': 'cltbld', 05:02:16 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088', 05:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:16 INFO - '_': '/tools/buildbot/bin/python'} 05:02:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 05:02:16 INFO - mozversion application_buildid: 20160929033005 05:02:16 INFO - mozversion application_changeset: dc21ccd6a304df32cdec43a71f01bdf80288ee98 05:02:16 INFO - mozversion application_display_name: Nightly 05:02:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:02:16 INFO - mozversion application_name: Firefox 05:02:16 INFO - mozversion application_remotingname: firefox 05:02:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:02:16 INFO - mozversion application_vendor: Mozilla 05:02:16 INFO - mozversion application_version: 52.0a1 05:02:16 INFO - mozversion platform_buildid: 20160929033005 05:02:16 INFO - mozversion platform_changeset: dc21ccd6a304df32cdec43a71f01bdf80288ee98 05:02:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:02:16 INFO - mozversion platform_version: 52.0a1 05:02:16 INFO - using testdate: 1475150536 05:02:16 INFO - actual date: 1475150536 05:02:16 INFO - starting webserver on 'localhost:51438' 05:02:16 INFO - SUITE-START | Running 2 tests 05:02:16 INFO - TEST-START | dromaeo_css 05:02:16 INFO - operating with platform_type : linux_ 05:02:16 INFO - Initialising browser for dromaeo_css test... 05:02:16 INFO - TEST-INFO | started process 5081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_K_yoJ/profile http://localhost:51438/getInfo.html) 05:02:21 INFO - PROCESS | 5081 | __metrics Screen width/height:1600/1200 05:02:21 INFO - PROCESS | 5081 | colorDepth:24 05:02:21 INFO - PROCESS | 5081 | Browser inner width/height: 1024/697 05:02:21 INFO - PROCESS | 5081 | __metrics 05:02:22 ERROR - PROCESS | 5081 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 05:02:22 INFO - TEST-INFO | 5081: exit 0 05:02:22 INFO - Browser initialized. 05:02:22 INFO - Running cycle 1/1 for dromaeo_css test... 05:02:22 INFO - TEST-INFO | started process 5202 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_K_yoJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:34 INFO - PROCESS | 5202 | RSS: Main: 185450496 05:02:34 INFO - PROCESS | 5202 | 05:03:24 INFO - PROCESS | 5202 | 1475150604614 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] 05:05:34 INFO - PROCESS | 5202 | Cycle 1(1): loaded http://localhost:51438/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51438/tests/dromaeo/cssquery-ext.html) 05:05:35 INFO - PROCESS | 5202 | RSS: Main: 202358784 05:05:35 INFO - PROCESS | 5202 | 05:08:37 INFO - PROCESS | 5202 | Cycle 1(1): loaded http://localhost:51438/tests/dromaeo/cssquery-ext.html (next: http://localhost:51438/tests/dromaeo/cssquery-jquery.html) 05:08:38 INFO - PROCESS | 5202 | RSS: Main: 198201344 05:08:38 INFO - PROCESS | 5202 | 05:11:40 INFO - PROCESS | 5202 | Cycle 1(1): loaded http://localhost:51438/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51438/tests/dromaeo/cssquery-mootools.html) 05:11:41 INFO - PROCESS | 5202 | RSS: Main: 198590464 05:11:41 INFO - PROCESS | 5202 | 05:14:43 INFO - PROCESS | 5202 | Cycle 1(1): loaded http://localhost:51438/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51438/tests/dromaeo/cssquery-prototype.html) 05:14:43 INFO - PROCESS | 5202 | RSS: Main: 195227648 05:14:43 INFO - PROCESS | 5202 | 05:17:46 INFO - PROCESS | 5202 | Cycle 1(1): loaded http://localhost:51438/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51438/tests/dromaeo/cssquery-yui.html) 05:17:46 INFO - PROCESS | 5202 | RSS: Main: 199147520 05:17:46 INFO - PROCESS | 5202 | 05:20:49 INFO - PROCESS | 5202 | Cycle 1(1): loaded http://localhost:51438/tests/dromaeo/cssquery-yui.html (next: http://localhost:51438/tests/dromaeo/cssquery-dojo.html) 05:20:49 INFO - PROCESS | 5202 | RSS: Main: 198963200 05:20:49 INFO - PROCESS | 5202 | 05:20:49 INFO - PROCESS | 5202 | __start_tp_report 05:20:49 INFO - PROCESS | 5202 | _x_x_mozilla_page_load 05:20:49 INFO - PROCESS | 5202 | _x_x_mozilla_page_load_details 05:20:49 INFO - PROCESS | 5202 | |i|pagename|runs| 05:20:49 INFO - PROCESS | 5202 | |0;dojo.html;3126.6248050233976;3139.8430078496085;3140.0893740815163;3162.0197738701004;3178.173674844541;5350.2777125088105;5454.699991500476;5469.234307196995;5514.3658479274845;5543;5285.2600635911;5312.096943519601;5358.089124848775;5372.623916325859;5436.157395603678;4882.877928051792;4927.876803079916;5009.524095210949;5083.923741143886;5095.3885533736;4919.72941488218;5023.9246411303675;5112.590992720592;5131.717755523445;5147.562457191143;4910.361652985089;4936.901261974776;5002.399712034543;5065.518775716301;5088.745562721868;4888.266759985995;4912.926306105412;4927.236278376858;4937.037277730844;4956.3804524434445;4865.221564549691;4870.318155458239;4877.244027175793;4979.261366462086;5005.89988200234;5380.166074258496;5390.299261096072;5395.406505284415;5412.377576578704;5414.242006119146;5738.913916291217;5800.970995144998;5820.621659592113;5820.679862607555;5884.382139875294;5830.591858569902;5862.97068514659;5922.733476993546;5927.851803704899;5928.851778705567;5380.811671591476;5431.1853222016225;5445.700486473203;5520.696361700105;5534.335879694462;5952;6035.577509574287;6039.456448919618;6079.452849243589;6099.603525770899;5761.164631128547;5776.046952252831;5782;5792.88414231713;5803.767849286066;5730.512906402919;5789.044807606698;5851.444112809277;5860.296764388216;5880.26496687914;5731.799387021434;5804.709764511842;5811.88376232473;5827;5829.591928565044;5814.30228372598;5843.29880414353;5845;5846.678432686158;5853;4400.4939431965095;4436.800343984529;4442.489113751895;4507.143642707875;4551.226291530382;3960.544537378181;3979.542352629485;4003.4195041718785;4029.073313137936;4095.692823038284;5609.915851262234;5616.719164041781;5616.747246373923;5619.494245517923;5651.604387692904;5759.078547432391;5883.94116058834;5900.4984576310635;5910.556708246812;5915.497182739516;5498.202760599691;5564.582656300713;5583.246261754693;5615.887682246333;5697.316322041299;5109.054824857413;5109.182530795129;5116.667416617908;5118.053160165381;5121.2574176744165;6096.298925623521;6097.817065488042;6125.632462052202;6135.662538560422;6139.938600613937;5656.151577263443;5660.207570940154;5804.622699524517;5837.970810145922;5885.028970219866;6082.9695851520455;6091.086337049478;6095.3904609538695;6104.481119104926;6108.602940808833;5615.3823079462045;5762.135679648086;5778.219940308005;5792.073268277056;5793.275840519935;5755.597108202385;5850.297964244318;5891;5897.115432685132;6001.639901605918;5765.077587585966;5772.942270577409;5773.134029895549;5775.6823374714795;5776.306843178845;5695.45893140151;5705.22979397776;5757.107648314518;5757.309122905278;5761;5496.890062198813;5524.558035357242;5593.972030139823;5597.104463285855;5616.129499927518;5730.426957304237;5738.196652468574;5741.3397459291045;5755.597108202385;5776.277965254343;5601.103823388238;5602.663840169603;5617.4101719320515;5618.494335509824;5635.126555383922 05:20:49 INFO - PROCESS | 5202 | |1;ext.html;539.8967114127909;578.1125971633542;588.3880764005432;595.5563105486414;599.0176111177668;42020.57979420205;42960.570394296046;43009.56990430099;46074.30888536674;46160.30759538601;44590.33114503277;45073.7746311268;45209.321860172124;45225;45253.32120018202;8982.595783189756;9113.726588202364;9122.494788359912;9130;9144.268458523335;8947.686830960918;8957.969833469137;9049.321300902426;9049.547522623876;9054.592543335533;8702.129787021278;8811.867821982676;8836.248918841875;8838;8897.199252067312;8881.33389995753;8993.10068993102;9011.594478248495;9058.184763371328;9063.682771103013;8740.51927144007;8800.339974501874;8801.075887031833;8818.897637795275;8897.288216942628;42573;42929;43107.784461077805;43205.13589728219;43293.56706432958;3197.8720851165926;3234.3531293741344;3353.1281866714585;3445.5693038370205;3665.798381089039;29673.70326296731;30271.697283027108;32174.195645108826;32537;32582.83708581442;4327.978360108211;4350.369196466526;4436.578525040116;4456.465224173087;4641.7911193996015;359557;367312;367811;368759;368765;62971.685141574;63765.36234637594;63783.36216637867;63849;63914.680426597566;66747.33252667412;67216.6639166801;67381.32618673751;67686.66156669284;67853;15020.849791501945;15301;15311.310991005208;15374.385024599114;15381;10981;11232.213745037769;11254.662360129209;11440.885591144148;11444.370559619134;19951.800481994993;19991.00179964013;20067.197312107353;20145.19419223244;20239.898800505904;7479.738209162653;7583.658735356922;7608.923910760822;7671.846563068819;7745.264199901;854.4403415762686;987.2102318145455;1001.2140469731225;1100.4552746390589;1102.9834552481718;31096.689033109833;32808.50787238193;32887.17782055468;33164.83417582897;33719;1099.796537640539;1105.7456784939347;1141.9086473082134;1154.6975649642018;1160.477784996738;16304.266308016167;16917.91541042287;16962;17101.004769918534;17160.227789749242;528184;529563.1567896226;530634;535590;536269;58304.12543811846;58322.708386457794;58836.411635883094;59078.40921590729;59117.113243301385;1275.2348590845418;1277.5464710027993;1317.2228385252747;1326.6683329167709;1332.980005299902;30266.84866575653;30910.53634195534;31666.525002124527;31670.841645791625;32078.518822218153;51001.23498147605;51354.22968655398;51396;51408;51588.48411515837;476171;478615;479779;479948;480121;29008.564871526523;29064.27339316534;29173.270668233465;29274.804389671284;29542.261443464085;47027.76486117548;47624.761876191784;47663.76168119137;48927.26609100795;49176.50823491863;39066.414003789396;40507.79746101251;40766;41592;42562.36156457718;40302;40442.19115617612;40856.79571602123;41487.377689334084;41884.79057604692;35134.82432587923;35714;38518.42222366723;39978.60021399865;40017.399739003355;34112.82943585266;36279.81860090682;37071;37077.443838341904;37322.253554928204;27661;28105.57841632418;28605.28486787847;33231.50152747663;33527.497087544194 05:20:49 INFO - PROCESS | 5202 | |2;jquery.html;385.1545856844226;391.1804769008927;391.47737770076947;396.734188093977;412.11806733590123;18045.909770451144;18960.241590336405;19344.80655193448;19640.21439142436;19706.507337316558;17001.2349444275;17198.140092995363;17468.825311746878;18331.90834045831;18512.537186570342;5494.862628434291;5525.861853453655;5676.801311954083;5729.770809167629;5744.856378590548;5540.36285827131;5627.127795191752;5629.043062679354;5635;5639.68981706006;5364.436734142917;5541.972290138544;5556.888862222753;5574.888502229953;5592.720363981784;5559.8888022239535;5594.748236329334;5597.104463285875;5611.9438805612035;5613.46672066153;4882.584980276681;4991.301217829507;5008.424031236418;5030.597552195815;5058.367704036996;21974.670379944153;22347.44131396712;22472.662910056362;22472.88763556188;22609.547809043892;2261.106862789189;2278.840481166319;2340.1224540797202;2404.7715467030603;2899.5070837957596;13551.25468099254;13620.795688064587;13620.795688064587;13635.250061246628;14303.213323267217;1830.5423644088978;1888.4429093417475;1920.0975541495475;1979.712941623471;1983.1670698306602;79747;79870.60064699697;80780.99999999942;82638;85664.57167714184;10560.841587376195;10738.79854629799;10749.301295415773;10959.3424394535;10973.286736362112;15002.474913377979;15052.397904083933;15069.849301507064;15094;15132.092074475346;7485.438592105614;7515.586642734593;7685.846283074419;7844.548758479586;7931.643076061591;7085.681144348517;7132.251113633098;7192.748253811092;7322.853542929111;7336.779896603004;4419.674097770656;4607.3319368691355;4610.700304480198;4691.3432119503295;4748.596369308648;1906.9427917162507;1939.5539026024094;1969.3107412405543;1982.1179575089236;1995.5310502032012;910.5356268303213;951.7070934566477;969.6170012844887;989.2086330935223;1069.3797597393493;18398.26406943707;18708.438746837615;18722.81277187238;19029.61940761205;19135.617287654168;935.9064093590587;936.9812603747887;944.6740874398322;962.9903700963041;999.195647503752;10129.696109116738;10318.845217321747;10501.422421766723;10556.841647375295;10561.471926403648;432759;437597;438205;446794;453636;87203.56398218095;87431;94956.52521737486;95521;95844.64543740936;990.5938565188238;1014.5789497358513;1015.6851376073441;1021.070825548747;1030.0986636692894;17096.40162594353;17163.65672686514;17852.821471785635;17917.104144792447;17993.370232041816;42029.57970420379;43306.78346608247;43412.348814767174;43889;44966.77516612396;52608;57213.99502034984;59335;61182.38817611767;62238.37761622326;10457.477126143815;10869;11310.773784524428;11743;11921.165518413627;12531.49874005066;12566;12678.112532123032;12792.74414511723;12996.870031299566;7595.658195381111;10775.784484310427;11131.220814542905;11246.887531124585;11548.191626586058;7505.737299194502;7533.849323013399;7807.765767026998;7845.13703492604;8189.344852411912;7780.299773020455;7788.805279868048;7971.202879711982;8018.919810801817;8091;11303.660890173307;11545.36500492481;11597.188196826479;11771.23486973344;12056.010758225146;10649.467526623483;11029.669109926715;11106.61126860556;11376.715582110513;11428.485718142538 05:20:49 INFO - PROCESS | 5202 | |3;mootools.html;1412.103314395359;1480.5336319059497;1556.9143697096663;1690.9323627054919;1720.3032771727446;7657.502262352943;7816.413768967322;8427.957860210698;9005.594748236337;9024.458532488046;8360.832783344329;8646.221840034395;8654.653813847453;8853.203211710945;8901.976272728638;2324.4886125052462;2333.9649905251435;2363.6809030780796;2373.8575685458927;2379.3456799380137;2255.3121298004103;2337.9649305260436;2346.6949296591506;2349.3539276698875;2354.72920614129;2317.3627252505526;2333.9066437342485;2343.6836027136374;2357.35172827473;2369.834111612188;2233.944151396212;2241.4172315198084;2256.311824893407;2257.7855103765196;2303.72355317363;2251.3696165073807;2269.047000259895;2271.239134889814;2272.3410211038777;2274.8407611467205;8880.689175878877;8916.242119419858;8917.331200160013;8927.553622318923;8940.061293564213;5196.662216955886;5267.525922666979;5322.281491998569;5330.333708286465;5339.70631615261;3282.2778988622463;3315.5689760331;3445.810480423576;3479.928483674107;3498.982505087484;1138.908887289015;1140.5950887434924;2095.182878677317;2141.807237348646;2147.892605369725;12293.3238671873;12323.938380308131;12400.751984960341;12412.689682757913;12423.93788031063;4460.999999999935;4524.6380289576755;4701.083288758728;4718.127146477913;4741.739204343725;9744.464054477072;9747.805043899225;9762.219022478184;9762.75593110178;9779.168770654433;5238.397584277781;5238.659487133325;5246.921296180561;5249.790008399697;5253.1857562077175;4304.612584867377;4459.264221403497;4577.267637178102;4685.1800934836265;4899.412070551557;3802.3726085196186;3891.7664940103687;3895.14306852492;3916.549596796348;3950.288947989332;1090.9127269818396;1099.8295264233896;1114.6098865397046;1121.058311018748;1126.4311522681157;744.4007573902952;808.2321794295443;880.6037283222576;887.4320434921656;933.5425641435647;5613.607047506635;5625.690587017753;6110.602810817282;6156.015037593964;6205.720742566596;948.8434408322687;958.1759686669459;972.8492083727034;979.7746518300688;998.1715176403568;3784.8296826642318;3937.625925537069;3976.1252524445154;4103;4117.670586353144;10999.175061870392;11165.441727913734;11195.160362972809;11281.605143819927;11339.659810205707;11044.282121662227;11086.722831929266;11128.443577821077;11253.718657033476;11297.378644174649;8249.597568413385;8319.625616847256;8368.3305335573;8384.903774056485;8386.287165590993;5513.365962914156;5585.357683866408;5604.047311956896;5649.757053448235;5753.424657534213;9762.85355719679;10011.349262297927;10126.189904807745;10174.084332410119;10242.283040187116;9970.102690757867;10352.948235258775;10364.378137311785;10400.635977740743;10562.155027597928;7472.514286571355;7600.619969001638;7621.961890190513;7907.762767116996;7912.9208707912185;8534.914650853412;8818.5590720465;8829.646814127364;8834.779130521789;8838.248748856418;7645.273698998586;7694.384449244159;7729.0725112984555;7971.402144839044;8022.037355517142;7569.735059273119;7602.581857997863;7725.111612164673;7810.258025487797;7842.529448233125;7101.396381307647;7178.174509931425;7193.820154496179;7193.928060719326;7209.279072092749;4920.138975679313;4994.375703037121;5023.196288593807;5079.6698214615935;5224.111900976919;5019.167335294648;5167.405748338839;5180.067587834226;5200.45395233495;5221.843344699665 05:20:49 INFO - PROCESS | 5202 | |4;prototype.html;310.91449851290895;317.52054397859234;322.3713758171566;322.58386681181247;328.20737917928204;5350.063738845696;5478.616496845222;5487.859734703459;5565.471280228377;5599.328080630325;5273.9736301318535;5390.8921821563545;5397.190421436777;5414.187871819219;5424.1321388577835;4245.87262382129;4257.957420425795;4288.9571104289025;4296.871093867189;4305.6124948754605;4202.70581059326;4252.532221455637;4290.120525292323;4295.055087880677;4314.784260786963;4266.082792199676;4271.483623313726;4277.893052673677;4280.400743895857;4281.272183728774;4271.359296105578;4288.16380805743;4299.226139294926;4299.50555686097;4316.892077698051;3691.354013047706;3838.769673819552;3838.9845331201063;3842.366009608439;3843.942340864889;5310.44240354761;5320.680759154425;5323.893522129574;5329.307190065306;5340.519353258225;4861.173600487926;4865.713114836021;4874.439439464471;4903.8528844134735;4914.655974081816;5502.367227768817;5680.375158732536;5727.885442291173;5735.193414074553;5753.309602847643;4109.890329611018;4110.301248787713;4116.794160292004;4160.356659119661;4189.790510474494;5952.255968003999;6016.187814645011;6045.153678485016;6057.121717351003;6069;4123.525794533607;4230.8519201827785;4270.487541494978;4276.893077673083;4278.165757677223;4225.915481690349;4242.978785106116;4269.765162916069;4274.786260686953;4287.356896465492;4821.349117869113;4892.192788189909;4900.901981960341;4902.607791376681;4934.925976110361;5707.600467967285;5766.971165144148;5782.537397008229;5808.448197421323;5815.94184058154;1473.4253641079988;1475.4909556203309;1479.408236705305;1480.9555713328402;1484.5323723027211;898.8471959766855;929.6188562689265;950.011987532958;955.5317894231777;955.5652178258875;4881.658283920092;4897;4905.402233995271;4919;4919.687746759089;5106.697792063;5133.537981581676;5164;5164.664296820694;5176.792928282902;4597.977010114928;4896.632752543574;4927.457979622239;4929.852104436801;4941.654084214142;2678.7990900682526;2697.9325516862236;2702.554078577052;2753.8433857779783;2763.9309017274727;5278.261043453919;5299.065840968019;5303.761330740049;5310.256564081032;5311;5200.349956255468;5290.867728306823;5657.660540367591;6088.360722124202;6115.969420152871;6157.907631385533;6158.137860699506;6193.380661933861;6197.946349120661;6200.56596038273;5686.2323586315315;5924;5928.34788173292;5980.282366116094;5980.611260268069;5839.941600584109;5910.881782364243;5941.970290148522;5942.494887934401;5978.940210597838;6203.410675985955;6217.720202590985;6223.070848037123;6224.657643829632;6259.749610015549;3817.1602247505502;3976.701747368901;4128.91742165161;4160.583941605815;4174.519930207944;5807.535397168132;5858.2677165354335;5898.35118136996;5946.43508866657;5991.490723288569;5702;5835.591508594527;5837.562182836219;5843.166064458649;5852.824415267549;5651.802186923438;5671.177679236405;5699.202111704281;5710.600257981901;5719.685417302088;5621.943780562306;5686.914696279477;5696.572757043321;5697.6296540724725;5726.570507211893;5608.887822243614;5796.507296879644;5799.217105690846;5825.737841797045;5828.289845221992;5706.543476521952;5733.59864809476;5752.568557358131;5752.769889204553;5767.192593036894 05:20:49 INFO - PROCESS | 5202 | |5;yui.html;698.8916717908722;719.8020544350306;726.5422783646305;742.8885667149927;805.367786287764;14344.211068391234;15772.290246938886;15786.921065394685;15797.36810527579;15841.28714207862;13692.657683557916;13770.793438098437;13799.379027943742;13802.65493362664;13811.65470863229;660.3297652882304;677.9830504237384;773.4044785515135;782.9530228186327;796.0248695348181;801.8476489466983;802.3500964218972;803.8553060449117;803.8713805791075;804.0391731880405;852.2457625001856;852.595017366752;853.9658413663477;854.2610641794865;854.786303424144;833.7373727275889;838.714836955432;843.173689784009;844.7676888855583;845.2055068235869;618.1438707390251;618.3816183816184;618.7030225491744;619.8729260501586;620.2928661326092;12848.22910625356;12894.097413181082;12925.289109098996;12929.676758081028;12950.54673086447;13998.510052148125;14008.0194386393;14243.78634320486;14285;14295.928520357436;10926.235163538555;10991.945040274748;11050;11123.27698699582;11231.887681123166;4295.4201182840225;4410.669199810027;4416.955830441687;4436.73379597222;4548.953393092126;72154.27845721527;72192.639036805;72225;72880.27119728788;74159;10498.632547860789;10515.579376824995;10575.153987680967;10765.461726913623;10775.515101820436;19976.60046799085;20042.098105585283;20110.597788044157;20146.496337591678;20705.89647051755;7769.456138070281;7859.567723775133;7970.123286438487;8099.595020248964;8129.349652027823;4294.871153865389;4460.8661740147845;4489.551044895549;4557.498675145731;4576.58810707038;3447;3626.9818650906577;3642.7996460194413;3657.7805331680183;3675.650813172798;610.7434877351523;615.793709107445;616.8858761129205;627.7614506487505;632.1971096707156;585.1018686316569;586.4633860018035;608.14251904814;679.3071067511111;698.678607840389;8966.625659748475;9493.145616894375;9927.453990030474;10143.23925705575;10331.32846364984;669.8124525132971;672.7040102354948;693.7710555516668;696.8641114982631;709.124231574016;4338.834718670112;4362.607365337071;4737.820343526886;4806;4828.686135401188;69613.65193174103;70540;70577;86770;127165.36417317855;60825.69587152036;86693;93146.53426732823;101532.30846144231;105191;91025;91625.54187229155;92080;92697;94664.52667736479;8711.520866352412;9270.258379329773;9333.486658233862;9391.953040234755;9424.104710052534;52532;52848.92237392749;53287.4671253298;54457.72771136119;55056.724716376164;76371;76931.23068769241;79637;80256;82296;11628.767424651629;11764.35296058725;11857.644270671894;12001.939990299992;12115.212511186744;12815.743685126432;13259.933700331436;13751.862481375058;14651.70696586041;14695.41218351254;13607.591772246848;13614.455421783017;13823.420687175025;14048;14501.129932204101;13158.934205328913;13412.12821166621;13471.865281347062;13560;14030.438782448588;12482.313472759086;12628.810567841307;12678.239305641691;13472.79790803119;13775.862241377457;10325.257582860428;10470.586470826342;10536.367817930948;10614.681559553226;10914.181436392144;10092.596296148366;10234.232432567438;10410.219233557362;11112;11460.94269528647 05:20:49 INFO - PROCESS | 5202 | __end_tp_report 05:20:49 INFO - PROCESS | 5202 | __start_cc_report 05:20:49 INFO - PROCESS | 5202 | _x_x_mozilla_cycle_collect,309 05:20:49 INFO - PROCESS | 5202 | __end_cc_report 05:20:49 INFO - PROCESS | 5202 | __startTimestamp1475151649602__endTimestamp 05:20:49 INFO - PROCESS | 5202 | 05:20:49 INFO - PROCESS | 5202 | ------- Summary: start ------- 05:20:49 INFO - PROCESS | 5202 | Number of tests: 6 05:20:49 INFO - PROCESS | 5202 | 05:20:49 INFO - PROCESS | 5202 | [#0] dojo.html Cycles:165 Average:5438.50 Median:5619.49 stddev:620.32 (11.0%) stddev-sans-first:595.12 05:20:49 INFO - PROCESS | 5202 | Values: 3126.6 3139.8 3140.1 3162.0 3178.2 5350.3 5454.7 5469.2 5514.4 5543.0 5285.3 5312.1 5358.1 5372.6 5436.2 4882.9 4927.9 5009.5 5083.9 5095.4 4919.7 5023.9 5112.6 5131.7 5147.6 4910.4 4936.9 5002.4 5065.5 5088.7 4888.3 4912.9 4927.2 4937.0 4956.4 4865.2 4870.3 4877.2 4979.3 5005.9 5380.2 5390.3 5395.4 5412.4 5414.2 5738.9 5801.0 5820.6 5820.7 5884.4 5830.6 5863.0 5922.7 5927.9 5928.9 5380.8 5431.2 5445.7 5520.7 5534.3 5952.0 6035.6 6039.5 6079.5 6099.6 5761.2 5776.0 5782.0 5792.9 5803.8 5730.5 5789.0 5851.4 5860.3 5880.3 5731.8 5804.7 5811.9 5827.0 5829.6 5814.3 5843.3 5845.0 5846.7 5853.0 4400.5 4436.8 4442.5 4507.1 4551.2 3960.5 3979.5 4003.4 4029.1 4095.7 5609.9 5616.7 5616.7 5619.5 5651.6 5759.1 5883.9 5900.5 5910.6 5915.5 5498.2 5564.6 5583.2 5615.9 5697.3 5109.1 5109.2 5116.7 5118.1 5121.3 6096.3 6097.8 6125.6 6135.7 6139.9 5656.2 5660.2 5804.6 5838.0 5885.0 6083.0 6091.1 6095.4 6104.5 6108.6 5615.4 5762.1 5778.2 5792.1 5793.3 5755.6 5850.3 5891.0 5897.1 6001.6 5765.1 5772.9 5773.1 5775.7 5776.3 5695.5 5705.2 5757.1 5757.3 5761.0 5496.9 5524.6 5594.0 5597.1 5616.1 5730.4 5738.2 5741.3 5755.6 5776.3 5601.1 5602.7 5617.4 5618.5 5635.1 05:20:49 INFO - PROCESS | 5202 | 05:20:49 INFO - PROCESS | 5202 | [#1] ext.html Cycles:180 Average:62154.34 Median:42944.79 stddev:123153.57 (286.8%) stddev-sans-first:123412.16 05:20:49 INFO - PROCESS | 5202 | Values: 539.9 578.1 588.4 595.6 599.0 42020.6 42960.6 43009.6 46074.3 46160.3 44590.3 45073.8 45209.3 45225.0 45253.3 8982.6 9113.7 9122.5 9130.0 9144.3 8947.7 8958.0 9049.3 9049.5 9054.6 8702.1 8811.9 8836.2 8838.0 8897.2 8881.3 8993.1 9011.6 9058.2 9063.7 8740.5 8800.3 8801.1 8818.9 8897.3 42573.0 42929.0 43107.8 43205.1 43293.6 3197.9 3234.4 3353.1 3445.6 3665.8 29673.7 30271.7 32174.2 32537.0 32582.8 4328.0 4350.4 4436.6 4456.5 4641.8 359557.0 367312.0 367811.0 368759.0 368765.0 62971.7 63765.4 63783.4 63849.0 63914.7 66747.3 67216.7 67381.3 67686.7 67853.0 15020.8 15301.0 15311.3 15374.4 15381.0 10981.0 11232.2 11254.7 11440.9 11444.4 19951.8 19991.0 20067.2 20145.2 20239.9 7479.7 7583.7 7608.9 7671.8 7745.3 854.4 987.2 1001.2 1100.5 1103.0 31096.7 32808.5 32887.2 33164.8 33719.0 1099.8 1105.7 1141.9 1154.7 1160.5 16304.3 16917.9 16962.0 17101.0 17160.2 528184.0 529563.2 530634.0 535590.0 536269.0 58304.1 58322.7 58836.4 59078.4 59117.1 1275.2 1277.5 1317.2 1326.7 1333.0 30266.8 30910.5 31666.5 31670.8 32078.5 51001.2 51354.2 51396.0 51408.0 51588.5 476171.0 478615.0 479779.0 479948.0 480121.0 29008.6 29064.3 29173.3 29274.8 29542.3 47027.8 47624.8 47663.8 48927.3 49176.5 39066.4 40507.8 40766.0 41592.0 42562.4 40302.0 40442.2 40856.8 41487.4 41884.8 35134.8 35714.0 38518.4 39978.6 40017.4 34112.8 36279.8 37071.0 37077.4 37322.3 27661.0 28105.6 28605.3 33231.5 33527.5 05:20:49 INFO - PROCESS | 5202 | 05:20:49 INFO - PROCESS | 5202 | [#2] jquery.html Cycles:180 Average:27579.79 Median:391.33 stddev:73225.48 (18712.0%) stddev-sans-first:73402.43 05:20:49 INFO - PROCESS | 5202 | Values: 385.2 391.2 391.5 396.7 412.1 18045.9 18960.2 19344.8 19640.2 19706.5 17001.2 17198.1 17468.8 18331.9 18512.5 5494.9 5525.9 5676.8 5729.8 5744.9 5540.4 5627.1 5629.0 5635.0 5639.7 5364.4 5542.0 5556.9 5574.9 5592.7 5559.9 5594.7 5597.1 5611.9 5613.5 4882.6 4991.3 5008.4 5030.6 5058.4 21974.7 22347.4 22472.7 22472.9 22609.5 2261.1 2278.8 2340.1 2404.8 2899.5 13551.3 13620.8 13620.8 13635.3 14303.2 1830.5 1888.4 1920.1 1979.7 1983.2 79747.0 79870.6 80781.0 82638.0 85664.6 10560.8 10738.8 10749.3 10959.3 10973.3 15002.5 15052.4 15069.8 15094.0 15132.1 7485.4 7515.6 7685.8 7844.5 7931.6 7085.7 7132.3 7192.7 7322.9 7336.8 4419.7 4607.3 4610.7 4691.3 4748.6 1906.9 1939.6 1969.3 1982.1 1995.5 910.5 951.7 969.6 989.2 1069.4 18398.3 18708.4 18722.8 19029.6 19135.6 935.9 937.0 944.7 963.0 999.2 10129.7 10318.8 10501.4 10556.8 10561.5 432759.0 437597.0 438205.0 446794.0 453636.0 87203.6 87431.0 94956.5 95521.0 95844.6 990.6 1014.6 1015.7 1021.1 1030.1 17096.4 17163.7 17852.8 17917.1 17993.4 42029.6 43306.8 43412.3 43889.0 44966.8 52608.0 57214.0 59335.0 61182.4 62238.4 10457.5 10869.0 11310.8 11743.0 11921.2 12531.5 12566.0 12678.1 12792.7 12996.9 7595.7 10775.8 11131.2 11246.9 11548.2 7505.7 7533.8 7807.8 7845.1 8189.3 7780.3 7788.8 7971.2 8018.9 8091.0 11303.7 11545.4 11597.2 11771.2 12056.0 10649.5 11029.7 11106.6 11376.7 11428.5 05:20:49 INFO - PROCESS | 5202 | 05:20:49 INFO - PROCESS | 5202 | [#3] mootools.html Cycles:180 Average:5804.86 Median:5021.18 stddev:3308.29 (65.9%) stddev-sans-first:3301.10 05:20:49 INFO - PROCESS | 5202 | Values: 1412.1 1480.5 1556.9 1690.9 1720.3 7657.5 7816.4 8428.0 9005.6 9024.5 8360.8 8646.2 8654.7 8853.2 8902.0 2324.5 2334.0 2363.7 2373.9 2379.3 2255.3 2338.0 2346.7 2349.4 2354.7 2317.4 2333.9 2343.7 2357.4 2369.8 2233.9 2241.4 2256.3 2257.8 2303.7 2251.4 2269.0 2271.2 2272.3 2274.8 8880.7 8916.2 8917.3 8927.6 8940.1 5196.7 5267.5 5322.3 5330.3 5339.7 3282.3 3315.6 3445.8 3479.9 3499.0 1138.9 1140.6 2095.2 2141.8 2147.9 12293.3 12323.9 12400.8 12412.7 12423.9 4461.0 4524.6 4701.1 4718.1 4741.7 9744.5 9747.8 9762.2 9762.8 9779.2 5238.4 5238.7 5246.9 5249.8 5253.2 4304.6 4459.3 4577.3 4685.2 4899.4 3802.4 3891.8 3895.1 3916.5 3950.3 1090.9 1099.8 1114.6 1121.1 1126.4 744.4 808.2 880.6 887.4 933.5 5613.6 5625.7 6110.6 6156.0 6205.7 948.8 958.2 972.8 979.8 998.2 3784.8 3937.6 3976.1 4103.0 4117.7 10999.2 11165.4 11195.2 11281.6 11339.7 11044.3 11086.7 11128.4 11253.7 11297.4 8249.6 8319.6 8368.3 8384.9 8386.3 5513.4 5585.4 5604.0 5649.8 5753.4 9762.9 10011.3 10126.2 10174.1 10242.3 9970.1 10352.9 10364.4 10400.6 10562.2 7472.5 7600.6 7622.0 7907.8 7912.9 8534.9 8818.6 8829.6 8834.8 8838.2 7645.3 7694.4 7729.1 7971.4 8022.0 7569.7 7602.6 7725.1 7810.3 7842.5 7101.4 7178.2 7193.8 7193.9 7209.3 4920.1 4994.4 5023.2 5079.7 5224.1 5019.2 5167.4 5180.1 5200.5 5221.8 05:20:49 INFO - PROCESS | 5202 | 05:20:49 INFO - PROCESS | 5202 | [#4] prototype.html Cycles:180 Average:4757.00 Median:5307.01 stddev:1415.70 (26.7%) stddev-sans-first:1379.78 05:20:49 INFO - PROCESS | 5202 | Values: 310.9 317.5 322.4 322.6 328.2 5350.1 5478.6 5487.9 5565.5 5599.3 5274.0 5390.9 5397.2 5414.2 5424.1 4245.9 4258.0 4289.0 4296.9 4305.6 4202.7 4252.5 4290.1 4295.1 4314.8 4266.1 4271.5 4277.9 4280.4 4281.3 4271.4 4288.2 4299.2 4299.5 4316.9 3691.4 3838.8 3839.0 3842.4 3843.9 5310.4 5320.7 5323.9 5329.3 5340.5 4861.2 4865.7 4874.4 4903.9 4914.7 5502.4 5680.4 5727.9 5735.2 5753.3 4109.9 4110.3 4116.8 4160.4 4189.8 5952.3 6016.2 6045.2 6057.1 6069.0 4123.5 4230.9 4270.5 4276.9 4278.2 4225.9 4243.0 4269.8 4274.8 4287.4 4821.3 4892.2 4900.9 4902.6 4934.9 5707.6 5767.0 5782.5 5808.4 5815.9 1473.4 1475.5 1479.4 1481.0 1484.5 898.8 929.6 950.0 955.5 955.6 4881.7 4897.0 4905.4 4919.0 4919.7 5106.7 5133.5 5164.0 5164.7 5176.8 4598.0 4896.6 4927.5 4929.9 4941.7 2678.8 2697.9 2702.6 2753.8 2763.9 5278.3 5299.1 5303.8 5310.3 5311.0 5200.3 5290.9 5657.7 6088.4 6116.0 6157.9 6158.1 6193.4 6197.9 6200.6 5686.2 5924.0 5928.3 5980.3 5980.6 5839.9 5910.9 5942.0 5942.5 5978.9 6203.4 6217.7 6223.1 6224.7 6259.7 3817.2 3976.7 4128.9 4160.6 4174.5 5807.5 5858.3 5898.4 5946.4 5991.5 5702.0 5835.6 5837.6 5843.2 5852.8 5651.8 5671.2 5699.2 5710.6 5719.7 5621.9 5686.9 5696.6 5697.6 5726.6 5608.9 5796.5 5799.2 5825.7 5828.3 5706.5 5733.6 5752.6 5752.8 5767.2 05:20:49 INFO - PROCESS | 5202 | 05:20:49 INFO - PROCESS | 5202 | [#5] yui.html Cycles:180 Average:19681.95 Median:4567.04 stddev:27890.80 (610.7%) stddev-sans-first:27932.62 05:20:49 INFO - PROCESS | 5202 | Values: 698.9 719.8 726.5 742.9 805.4 14344.2 15772.3 15786.9 15797.4 15841.3 13692.7 13770.8 13799.4 13802.7 13811.7 660.3 678.0 773.4 783.0 796.0 801.8 802.4 803.9 803.9 804.0 852.2 852.6 854.0 854.3 854.8 833.7 838.7 843.2 844.8 845.2 618.1 618.4 618.7 619.9 620.3 12848.2 12894.1 12925.3 12929.7 12950.5 13998.5 14008.0 14243.8 14285.0 14295.9 10926.2 10991.9 11050.0 11123.3 11231.9 4295.4 4410.7 4417.0 4436.7 4549.0 72154.3 72192.6 72225.0 72880.3 74159.0 10498.6 10515.6 10575.2 10765.5 10775.5 19976.6 20042.1 20110.6 20146.5 20705.9 7769.5 7859.6 7970.1 8099.6 8129.3 4294.9 4460.9 4489.6 4557.5 4576.6 3447.0 3627.0 3642.8 3657.8 3675.7 610.7 615.8 616.9 627.8 632.2 585.1 586.5 608.1 679.3 698.7 8966.6 9493.1 9927.5 10143.2 10331.3 669.8 672.7 693.8 696.9 709.1 4338.8 4362.6 4737.8 4806.0 4828.7 69613.7 70540.0 70577.0 86770.0 127165.4 60825.7 86693.0 93146.5 101532.3 105191.0 91025.0 91625.5 92080.0 92697.0 94664.5 8711.5 9270.3 9333.5 9392.0 9424.1 52532.0 52848.9 53287.5 54457.7 55056.7 76371.0 76931.2 79637.0 80256.0 82296.0 11628.8 11764.4 11857.6 12001.9 12115.2 12815.7 13259.9 13751.9 14651.7 14695.4 13607.6 13614.5 13823.4 14048.0 14501.1 13158.9 13412.1 13471.9 13560.0 14030.4 12482.3 12628.8 12678.2 13472.8 13775.9 10325.3 10470.6 10536.4 10614.7 10914.2 10092.6 10234.2 10410.2 11112.0 11460.9 05:20:49 INFO - PROCESS | 5202 | -------- Summary: end -------- 05:20:49 INFO - PROCESS | 5202 | 05:20:50 INFO - TEST-INFO | 5202: exit 0 05:20:50 INFO - TEST-OK | dromaeo_css | took 1113904ms 05:20:50 INFO - TEST-START | kraken 05:20:50 INFO - operating with platform_type : linux_ 05:20:50 INFO - Initialising browser for kraken test... 05:20:50 INFO - TEST-INFO | started process 5564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDDFbJh/profile http://localhost:51438/getInfo.html) 05:20:55 INFO - PROCESS | 5564 | __metrics Screen width/height:1600/1200 05:20:55 INFO - PROCESS | 5564 | colorDepth:24 05:20:55 INFO - PROCESS | 5564 | Browser inner width/height: 1024/697 05:20:55 INFO - PROCESS | 5564 | __metrics 05:20:55 ERROR - PROCESS | 5564 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 05:20:56 INFO - TEST-INFO | 5564: exit 0 05:20:56 INFO - Browser initialized. 05:20:56 INFO - Running cycle 1/1 for kraken test... 05:20:56 INFO - TEST-INFO | started process 5686 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDDFbJh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:08 INFO - PROCESS | 5686 | RSS: Main: 186019840 05:21:08 INFO - PROCESS | 5686 | 05:21:11 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51438/tests/kraken/driver.html?testName=audio-beat-detection) 05:21:12 INFO - PROCESS | 5686 | RSS: Main: 199966720 05:21:12 INFO - PROCESS | 5686 | 05:21:15 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51438/tests/kraken/driver.html?testName=audio-dft) 05:21:15 INFO - PROCESS | 5686 | RSS: Main: 197632000 05:21:15 INFO - PROCESS | 5686 | 05:21:18 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51438/tests/kraken/driver.html?testName=audio-fft) 05:21:19 INFO - PROCESS | 5686 | RSS: Main: 193789952 05:21:19 INFO - PROCESS | 5686 | 05:21:21 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51438/tests/kraken/driver.html?testName=audio-oscillator) 05:21:21 INFO - PROCESS | 5686 | RSS: Main: 193908736 05:21:21 INFO - PROCESS | 5686 | 05:21:24 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51438/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:21:24 INFO - PROCESS | 5686 | RSS: Main: 193888256 05:21:24 INFO - PROCESS | 5686 | 05:21:27 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51438/tests/kraken/driver.html?testName=imaging-darkroom) 05:21:28 INFO - PROCESS | 5686 | RSS: Main: 194568192 05:21:28 INFO - PROCESS | 5686 | 05:21:31 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51438/tests/kraken/driver.html?testName=imaging-desaturate) 05:21:32 INFO - PROCESS | 5686 | RSS: Main: 192172032 05:21:32 INFO - PROCESS | 5686 | 05:21:35 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51438/tests/kraken/driver.html?testName=json-parse-financial) 05:21:35 INFO - PROCESS | 5686 | RSS: Main: 193650688 05:21:35 INFO - PROCESS | 5686 | 05:21:37 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51438/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:21:38 INFO - PROCESS | 5686 | RSS: Main: 193937408 05:21:38 INFO - PROCESS | 5686 | 05:21:39 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51438/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:21:40 INFO - PROCESS | 5686 | RSS: Main: 193875968 05:21:40 INFO - PROCESS | 5686 | 05:21:42 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51438/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:21:43 INFO - PROCESS | 5686 | RSS: Main: 194314240 05:21:43 INFO - PROCESS | 5686 | 05:21:45 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:21:46 INFO - PROCESS | 5686 | RSS: Main: 194277376 05:21:46 INFO - PROCESS | 5686 | 05:21:49 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:21:49 INFO - PROCESS | 5686 | RSS: Main: 195018752 05:21:49 INFO - PROCESS | 5686 | 05:21:51 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51438/tests/kraken/driver.html?testName=ai-astar) 05:21:51 INFO - PROCESS | 5686 | RSS: Main: 196235264 05:21:51 INFO - PROCESS | 5686 | 05:21:51 INFO - PROCESS | 5686 | __start_tp_report 05:21:51 INFO - PROCESS | 5686 | _x_x_mozilla_page_load 05:21:51 INFO - PROCESS | 5686 | _x_x_mozilla_page_load_details 05:21:51 INFO - PROCESS | 5686 | |i|pagename|runs| 05:21:51 INFO - PROCESS | 5686 | |0;ai-astar;105;114;114;114;112;114;113;113;113;113 05:21:51 INFO - PROCESS | 5686 | |1;audio-beat-detection;143;122;121;165;122;124;121;120;157;131 05:21:51 INFO - PROCESS | 5686 | |2;audio-dft;163;164;163;165;173;163;160;163;161;163 05:21:51 INFO - PROCESS | 5686 | |3;audio-fft;77;76;76;119;78;76;77;77;104;76 05:21:51 INFO - PROCESS | 5686 | |4;audio-oscillator;83;82;122;82;82;83;99;83;83;123 05:21:51 INFO - PROCESS | 5686 | |5;imaging-gaussian-blur;118;117;118;117;118;120;118;118;117;117 05:21:51 INFO - PROCESS | 5686 | |6;imaging-darkroom;148;150;147;147;148;148;147;147;146;147 05:21:51 INFO - PROCESS | 5686 | |7;imaging-desaturate;96;97;95;95;96;96;96;96;97;97 05:21:51 INFO - PROCESS | 5686 | |8;json-parse-financial;53;51;51;52;53;54;52;53;52;52 05:21:51 INFO - PROCESS | 5686 | |9;json-stringify-tinderbox;60;61;61;60;60;59;60;60;60;61 05:21:51 INFO - PROCESS | 5686 | |10;stanford-crypto-aes;81;87;85;81;79;80;82;79;80;80 05:21:51 INFO - PROCESS | 5686 | |11;stanford-crypto-ccm;129;127;130;134;129;128;138;133;168;126 05:21:51 INFO - PROCESS | 5686 | |12;stanford-crypto-pbkdf2;163;165;161;164;164;165;162;162;161;162 05:21:51 INFO - PROCESS | 5686 | |13;stanford-crypto-sha256-iterative;67;66;66;67;65;64;64;65;65;64 05:21:51 INFO - PROCESS | 5686 | __end_tp_report 05:21:51 INFO - PROCESS | 5686 | __start_cc_report 05:21:51 INFO - PROCESS | 5686 | _x_x_mozilla_cycle_collect,764 05:21:51 INFO - PROCESS | 5686 | __end_cc_report 05:21:51 INFO - PROCESS | 5686 | __startTimestamp1475151711897__endTimestamp 05:21:51 INFO - PROCESS | 5686 | 05:21:51 INFO - PROCESS | 5686 | ------- Summary: start ------- 05:21:51 INFO - PROCESS | 5686 | Number of tests: 14 05:21:51 INFO - PROCESS | 5686 | 05:21:51 INFO - PROCESS | 5686 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.50 stddev:2.72 (2.4%) stddev-sans-first:0.71 05:21:51 INFO - PROCESS | 5686 | Values: 105.0 114.0 114.0 114.0 112.0 114.0 113.0 113.0 113.0 113.0 05:21:51 INFO - PROCESS | 5686 | 05:21:51 INFO - PROCESS | 5686 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:127.50 stddev:16.61 (13.0%) stddev-sans-first:17.18 05:21:51 INFO - PROCESS | 5686 | Values: 143.0 122.0 121.0 165.0 122.0 124.0 121.0 120.0 157.0 131.0 05:21:51 INFO - PROCESS | 5686 | 05:21:51 INFO - PROCESS | 5686 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:3.52 (2.2%) stddev-sans-first:3.72 05:21:51 INFO - PROCESS | 5686 | Values: 163.0 164.0 163.0 165.0 173.0 163.0 160.0 163.0 161.0 163.0 05:21:51 INFO - PROCESS | 5686 | 05:21:51 INFO - PROCESS | 5686 | [#3] audio-fft Cycles:10 Average:83.60 Median:76.50 stddev:15.14 (19.8%) stddev-sans-first:15.87 05:21:51 INFO - PROCESS | 5686 | Values: 77.0 76.0 76.0 119.0 78.0 76.0 77.0 77.0 104.0 76.0 05:21:51 INFO - PROCESS | 5686 | 05:21:51 INFO - PROCESS | 5686 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:83.00 stddev:16.78 (20.2%) stddev-sans-first:17.46 05:21:51 INFO - PROCESS | 5686 | Values: 83.0 82.0 122.0 82.0 82.0 83.0 99.0 83.0 83.0 123.0 05:21:51 INFO - PROCESS | 5686 | 05:21:51 INFO - PROCESS | 5686 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 05:21:51 INFO - PROCESS | 5686 | Values: 118.0 117.0 118.0 117.0 118.0 120.0 118.0 118.0 117.0 117.0 05:21:51 INFO - PROCESS | 5686 | 05:21:51 INFO - PROCESS | 5686 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 05:21:51 INFO - PROCESS | 5686 | Values: 148.0 150.0 147.0 147.0 148.0 148.0 147.0 147.0 146.0 147.0 05:21:51 INFO - PROCESS | 5686 | 05:21:51 INFO - PROCESS | 5686 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 05:21:51 INFO - PROCESS | 5686 | Values: 96.0 97.0 95.0 95.0 96.0 96.0 96.0 96.0 97.0 97.0 05:21:51 INFO - PROCESS | 5686 | 05:21:51 INFO - PROCESS | 5686 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.50 stddev:0.95 (1.8%) stddev-sans-first:0.97 05:21:51 INFO - PROCESS | 5686 | Values: 53.0 51.0 51.0 52.0 53.0 54.0 52.0 53.0 52.0 52.0 05:21:51 INFO - PROCESS | 5686 | 05:21:51 INFO - PROCESS | 5686 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 05:21:51 INFO - PROCESS | 5686 | Values: 60.0 61.0 61.0 60.0 60.0 59.0 60.0 60.0 60.0 61.0 05:21:51 INFO - PROCESS | 5686 | 05:21:51 INFO - PROCESS | 5686 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.00 stddev:2.63 (3.3%) stddev-sans-first:2.79 05:21:51 INFO - PROCESS | 5686 | Values: 81.0 87.0 85.0 81.0 79.0 80.0 82.0 79.0 80.0 80.0 05:21:51 INFO - PROCESS | 5686 | 05:21:51 INFO - PROCESS | 5686 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:131.50 stddev:12.42 (9.4%) stddev-sans-first:13.03 05:21:51 INFO - PROCESS | 5686 | Values: 129.0 127.0 130.0 134.0 129.0 128.0 138.0 133.0 168.0 126.0 05:21:51 INFO - PROCESS | 5686 | 05:21:51 INFO - PROCESS | 5686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:163.50 stddev:1.52 (0.9%) stddev-sans-first:1.62 05:21:51 INFO - PROCESS | 5686 | Values: 163.0 165.0 161.0 164.0 164.0 165.0 162.0 162.0 161.0 162.0 05:21:51 INFO - PROCESS | 5686 | 05:21:51 INFO - PROCESS | 5686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:1.16 (1.8%) stddev-sans-first:1.05 05:21:51 INFO - PROCESS | 5686 | Values: 67.0 66.0 66.0 67.0 65.0 64.0 64.0 65.0 65.0 64.0 05:21:51 INFO - PROCESS | 5686 | -------- Summary: end -------- 05:21:51 INFO - PROCESS | 5686 | 05:21:52 INFO - PROCESS | 5686 | 05:21:52 INFO - PROCESS | 5686 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 05:21:52 INFO - PROCESS | 5686 | 05:21:52 INFO - PROCESS | 5686 | 05:21:52 INFO - PROCESS | 5686 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 05:21:52 INFO - PROCESS | 5686 | 05:21:52 INFO - PROCESS | 5686 | 05:21:52 INFO - PROCESS | 5686 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 05:21:52 INFO - PROCESS | 5686 | 05:21:52 INFO - PROCESS | 5686 | 05:21:52 INFO - PROCESS | 5686 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 05:21:52 INFO - PROCESS | 5686 | 05:21:52 INFO - PROCESS | 5686 | 05:21:52 INFO - PROCESS | 5686 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 05:21:52 INFO - PROCESS | 5686 | 05:21:52 INFO - TEST-INFO | 5686: exit 0 05:21:53 INFO - TEST-OK | kraken | took 62362ms 05:21:53 INFO - SUITE-END | took 1176s 05:21:53 INFO - Completed test suite (00:19:36) 05:21:53 INFO - javascript benchmark 05:21:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7240.463849435789, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3126.6248050233976, 3139.8430078496085, 3140.0893740815163, 3162.0197738701004, 3178.173674844541, 5350.2777125088105, 5454.699991500476, 5469.234307196995, 5514.3658479274845, 5543.0, 5285.2600635911, 5312.096943519601, 5358.089124848775, 5372.623916325859, 5436.157395603678, 4882.877928051792, 4927.876803079916, 5009.524095210949, 5083.923741143886, 5095.3885533736, 4919.72941488218, 5023.9246411303675, 5112.590992720592, 5131.717755523445, 5147.562457191143, 4910.361652985089, 4936.901261974776, 5002.399712034543, 5065.518775716301, 5088.745562721868, 4888.266759985995, 4912.926306105412, 4927.236278376858, 4937.037277730844, 4956.3804524434445, 4865.221564549691, 4870.318155458239, 4877.244027175793, 4979.261366462086, 5005.89988200234, 5380.166074258496, 5390.299261096072, 5395.406505284415, 5412.377576578704, 5414.242006119146, 5738.913916291217, 5800.970995144998, 5820.621659592113, 5820.679862607555, 5884.382139875294, 5830.591858569902, 5862.97068514659, 5922.733476993546, 5927.851803704899, 5928.851778705567, 5380.811671591476, 5431.1853222016225, 5445.700486473203, 5520.696361700105, 5534.335879694462, 5952.0, 6035.577509574287, 6039.456448919618, 6079.452849243589, 6099.603525770899, 5761.164631128547, 5776.046952252831, 5782.0, 5792.88414231713, 5803.767849286066, 5730.512906402919, 5789.044807606698, 5851.444112809277, 5860.296764388216, 5880.26496687914, 5731.799387021434, 5804.709764511842, 5811.88376232473, 5827.0, 5829.591928565044, 5814.30228372598, 5843.29880414353, 5845.0, 5846.678432686158, 5853.0, 4400.4939431965095, 4436.800343984529, 4442.489113751895, 4507.143642707875, 4551.226291530382, 3960.544537378181, 3979.542352629485, 4003.4195041718785, 4029.073313137936, 4095.692823038284, 5609.915851262234, 5616.719164041781, 5616.747246373923, 5619.494245517923, 5651.604387692904, 5759.078547432391, 5883.94116058834, 5900.4984576310635, 5910.556708246812, 5915.497182739516, 5498.202760599691, 5564.582656300713, 5583.246261754693, 5615.887682246333, 5697.316322041299, 5109.054824857413, 5109.182530795129, 5116.667416617908, 5118.053160165381, 5121.2574176744165, 6096.298925623521, 6097.817065488042, 6125.632462052202, 6135.662538560422, 6139.938600613937, 5656.151577263443, 5660.207570940154, 5804.622699524517, 5837.970810145922, 5885.028970219866, 6082.9695851520455, 6091.086337049478, 6095.3904609538695, 6104.481119104926, 6108.602940808833, 5615.3823079462045, 5762.135679648086, 5778.219940308005, 5792.073268277056, 5793.275840519935, 5755.597108202385, 5850.297964244318, 5891.0, 5897.115432685132, 6001.639901605918, 5765.077587585966, 5772.942270577409, 5773.134029895549, 5775.6823374714795, 5776.306843178845, 5695.45893140151, 5705.22979397776, 5757.107648314518, 5757.309122905278, 5761.0, 5496.890062198813, 5524.558035357242, 5593.972030139823, 5597.104463285855, 5616.129499927518, 5730.426957304237, 5738.196652468574, 5741.3397459291045, 5755.597108202385, 5776.277965254343, 5601.103823388238, 5602.663840169603, 5617.4101719320515, 5618.494335509824, 5635.126555383922], "value": 5396.3715609753535, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.8967114127909, 578.1125971633542, 588.3880764005432, 595.5563105486414, 599.0176111177668, 42020.57979420205, 42960.570394296046, 43009.56990430099, 46074.30888536674, 46160.30759538601, 44590.33114503277, 45073.7746311268, 45209.321860172124, 45225.0, 45253.32120018202, 8982.595783189756, 9113.726588202364, 9122.494788359912, 9130.0, 9144.268458523335, 8947.686830960918, 8957.969833469137, 9049.321300902426, 9049.547522623876, 9054.592543335533, 8702.129787021278, 8811.867821982676, 8836.248918841875, 8838.0, 8897.199252067312, 8881.33389995753, 8993.10068993102, 9011.594478248495, 9058.184763371328, 9063.682771103013, 8740.51927144007, 8800.339974501874, 8801.075887031833, 8818.897637795275, 8897.288216942628, 42573.0, 42929.0, 43107.784461077805, 43205.13589728219, 43293.56706432958, 3197.8720851165926, 3234.3531293741344, 3353.1281866714585, 3445.5693038370205, 3665.798381089039, 29673.70326296731, 30271.697283027108, 32174.195645108826, 32537.0, 32582.83708581442, 4327.978360108211, 4350.369196466526, 4436.578525040116, 4456.465224173087, 4641.7911193996015, 359557.0, 367312.0, 367811.0, 368759.0, 368765.0, 62971.685141574, 63765.36234637594, 63783.36216637867, 63849.0, 63914.680426597566, 66747.33252667412, 67216.6639166801, 67381.32618673751, 67686.66156669284, 67853.0, 15020.849791501945, 15301.0, 15311.310991005208, 15374.385024599114, 15381.0, 10981.0, 11232.213745037769, 11254.662360129209, 11440.885591144148, 11444.370559619134, 19951.800481994993, 19991.00179964013, 20067.197312107353, 20145.19419223244, 20239.898800505904, 7479.738209162653, 7583.658735356922, 7608.923910760822, 7671.846563068819, 7745.264199901, 854.4403415762686, 987.2102318145455, 1001.2140469731225, 1100.4552746390589, 1102.9834552481718, 31096.689033109833, 32808.50787238193, 32887.17782055468, 33164.83417582897, 33719.0, 1099.796537640539, 1105.7456784939347, 1141.9086473082134, 1154.6975649642018, 1160.477784996738, 16304.266308016167, 16917.91541042287, 16962.0, 17101.004769918534, 17160.227789749242, 528184.0, 529563.1567896226, 530634.0, 535590.0, 536269.0, 58304.12543811846, 58322.708386457794, 58836.411635883094, 59078.40921590729, 59117.113243301385, 1275.2348590845418, 1277.5464710027993, 1317.2228385252747, 1326.6683329167709, 1332.980005299902, 30266.84866575653, 30910.53634195534, 31666.525002124527, 31670.841645791625, 32078.518822218153, 51001.23498147605, 51354.22968655398, 51396.0, 51408.0, 51588.48411515837, 476171.0, 478615.0, 479779.0, 479948.0, 480121.0, 29008.564871526523, 29064.27339316534, 29173.270668233465, 29274.804389671284, 29542.261443464085, 47027.76486117548, 47624.761876191784, 47663.76168119137, 48927.26609100795, 49176.50823491863, 39066.414003789396, 40507.79746101251, 40766.0, 41592.0, 42562.36156457718, 40302.0, 40442.19115617612, 40856.79571602123, 41487.377689334084, 41884.79057604692, 35134.82432587923, 35714.0, 38518.42222366723, 39978.60021399865, 40017.399739003355, 34112.82943585266, 36279.81860090682, 37071.0, 37077.443838341904, 37322.253554928204, 27661.0, 28105.57841632418, 28605.28486787847, 33231.50152747663, 33527.497087544194], "value": 20256.10423589709, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.1545856844226, 391.1804769008927, 391.47737770076947, 396.734188093977, 412.11806733590123, 18045.909770451144, 18960.241590336405, 19344.80655193448, 19640.21439142436, 19706.507337316558, 17001.2349444275, 17198.140092995363, 17468.825311746878, 18331.90834045831, 18512.537186570342, 5494.862628434291, 5525.861853453655, 5676.801311954083, 5729.770809167629, 5744.856378590548, 5540.36285827131, 5627.127795191752, 5629.043062679354, 5635.0, 5639.68981706006, 5364.436734142917, 5541.972290138544, 5556.888862222753, 5574.888502229953, 5592.720363981784, 5559.8888022239535, 5594.748236329334, 5597.104463285875, 5611.9438805612035, 5613.46672066153, 4882.584980276681, 4991.301217829507, 5008.424031236418, 5030.597552195815, 5058.367704036996, 21974.670379944153, 22347.44131396712, 22472.662910056362, 22472.88763556188, 22609.547809043892, 2261.106862789189, 2278.840481166319, 2340.1224540797202, 2404.7715467030603, 2899.5070837957596, 13551.25468099254, 13620.795688064587, 13620.795688064587, 13635.250061246628, 14303.213323267217, 1830.5423644088978, 1888.4429093417475, 1920.0975541495475, 1979.712941623471, 1983.1670698306602, 79747.0, 79870.60064699697, 80780.99999999942, 82638.0, 85664.57167714184, 10560.841587376195, 10738.79854629799, 10749.301295415773, 10959.3424394535, 10973.286736362112, 15002.474913377979, 15052.397904083933, 15069.849301507064, 15094.0, 15132.092074475346, 7485.438592105614, 7515.586642734593, 7685.846283074419, 7844.548758479586, 7931.643076061591, 7085.681144348517, 7132.251113633098, 7192.748253811092, 7322.853542929111, 7336.779896603004, 4419.674097770656, 4607.3319368691355, 4610.700304480198, 4691.3432119503295, 4748.596369308648, 1906.9427917162507, 1939.5539026024094, 1969.3107412405543, 1982.1179575089236, 1995.5310502032012, 910.5356268303213, 951.7070934566477, 969.6170012844887, 989.2086330935223, 1069.3797597393493, 18398.26406943707, 18708.438746837615, 18722.81277187238, 19029.61940761205, 19135.617287654168, 935.9064093590587, 936.9812603747887, 944.6740874398322, 962.9903700963041, 999.195647503752, 10129.696109116738, 10318.845217321747, 10501.422421766723, 10556.841647375295, 10561.471926403648, 432759.0, 437597.0, 438205.0, 446794.0, 453636.0, 87203.56398218095, 87431.0, 94956.52521737486, 95521.0, 95844.64543740936, 990.5938565188238, 1014.5789497358513, 1015.6851376073441, 1021.070825548747, 1030.0986636692894, 17096.40162594353, 17163.65672686514, 17852.821471785635, 17917.104144792447, 17993.370232041816, 42029.57970420379, 43306.78346608247, 43412.348814767174, 43889.0, 44966.77516612396, 52608.0, 57213.99502034984, 59335.0, 61182.38817611767, 62238.37761622326, 10457.477126143815, 10869.0, 11310.773784524428, 11743.0, 11921.165518413627, 12531.49874005066, 12566.0, 12678.112532123032, 12792.74414511723, 12996.870031299566, 7595.658195381111, 10775.784484310427, 11131.220814542905, 11246.887531124585, 11548.191626586058, 7505.737299194502, 7533.849323013399, 7807.765767026998, 7845.13703492604, 8189.344852411912, 7780.299773020455, 7788.805279868048, 7971.202879711982, 8018.919810801817, 8091.0, 11303.660890173307, 11545.36500492481, 11597.188196826479, 11771.23486973344, 12056.010758225146, 10649.467526623483, 11029.669109926715, 11106.61126860556, 11376.715582110513, 11428.485718142538], "value": 9032.412004268966, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1412.103314395359, 1480.5336319059497, 1556.9143697096663, 1690.9323627054919, 1720.3032771727446, 7657.502262352943, 7816.413768967322, 8427.957860210698, 9005.594748236337, 9024.458532488046, 8360.832783344329, 8646.221840034395, 8654.653813847453, 8853.203211710945, 8901.976272728638, 2324.4886125052462, 2333.9649905251435, 2363.6809030780796, 2373.8575685458927, 2379.3456799380137, 2255.3121298004103, 2337.9649305260436, 2346.6949296591506, 2349.3539276698875, 2354.72920614129, 2317.3627252505526, 2333.9066437342485, 2343.6836027136374, 2357.35172827473, 2369.834111612188, 2233.944151396212, 2241.4172315198084, 2256.311824893407, 2257.7855103765196, 2303.72355317363, 2251.3696165073807, 2269.047000259895, 2271.239134889814, 2272.3410211038777, 2274.8407611467205, 8880.689175878877, 8916.242119419858, 8917.331200160013, 8927.553622318923, 8940.061293564213, 5196.662216955886, 5267.525922666979, 5322.281491998569, 5330.333708286465, 5339.70631615261, 3282.2778988622463, 3315.5689760331, 3445.810480423576, 3479.928483674107, 3498.982505087484, 1138.908887289015, 1140.5950887434924, 2095.182878677317, 2141.807237348646, 2147.892605369725, 12293.3238671873, 12323.938380308131, 12400.751984960341, 12412.689682757913, 12423.93788031063, 4460.999999999935, 4524.6380289576755, 4701.083288758728, 4718.127146477913, 4741.739204343725, 9744.464054477072, 9747.805043899225, 9762.219022478184, 9762.75593110178, 9779.168770654433, 5238.397584277781, 5238.659487133325, 5246.921296180561, 5249.790008399697, 5253.1857562077175, 4304.612584867377, 4459.264221403497, 4577.267637178102, 4685.1800934836265, 4899.412070551557, 3802.3726085196186, 3891.7664940103687, 3895.14306852492, 3916.549596796348, 3950.288947989332, 1090.9127269818396, 1099.8295264233896, 1114.6098865397046, 1121.058311018748, 1126.4311522681157, 744.4007573902952, 808.2321794295443, 880.6037283222576, 887.4320434921656, 933.5425641435647, 5613.607047506635, 5625.690587017753, 6110.602810817282, 6156.015037593964, 6205.720742566596, 948.8434408322687, 958.1759686669459, 972.8492083727034, 979.7746518300688, 998.1715176403568, 3784.8296826642318, 3937.625925537069, 3976.1252524445154, 4103.0, 4117.670586353144, 10999.175061870392, 11165.441727913734, 11195.160362972809, 11281.605143819927, 11339.659810205707, 11044.282121662227, 11086.722831929266, 11128.443577821077, 11253.718657033476, 11297.378644174649, 8249.597568413385, 8319.625616847256, 8368.3305335573, 8384.903774056485, 8386.287165590993, 5513.365962914156, 5585.357683866408, 5604.047311956896, 5649.757053448235, 5753.424657534213, 9762.85355719679, 10011.349262297927, 10126.189904807745, 10174.084332410119, 10242.283040187116, 9970.102690757867, 10352.948235258775, 10364.378137311785, 10400.635977740743, 10562.155027597928, 7472.514286571355, 7600.619969001638, 7621.961890190513, 7907.762767116996, 7912.9208707912185, 8534.914650853412, 8818.5590720465, 8829.646814127364, 8834.779130521789, 8838.248748856418, 7645.273698998586, 7694.384449244159, 7729.0725112984555, 7971.402144839044, 8022.037355517142, 7569.735059273119, 7602.581857997863, 7725.111612164673, 7810.258025487797, 7842.529448233125, 7101.396381307647, 7178.174509931425, 7193.820154496179, 7193.928060719326, 7209.279072092749, 4920.138975679313, 4994.375703037121, 5023.196288593807, 5079.6698214615935, 5224.111900976919, 5019.167335294648, 5167.405748338839, 5180.067587834226, 5200.45395233495, 5221.843344699665], "value": 4654.849404105694, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.91449851290895, 317.52054397859234, 322.3713758171566, 322.58386681181247, 328.20737917928204, 5350.063738845696, 5478.616496845222, 5487.859734703459, 5565.471280228377, 5599.328080630325, 5273.9736301318535, 5390.8921821563545, 5397.190421436777, 5414.187871819219, 5424.1321388577835, 4245.87262382129, 4257.957420425795, 4288.9571104289025, 4296.871093867189, 4305.6124948754605, 4202.70581059326, 4252.532221455637, 4290.120525292323, 4295.055087880677, 4314.784260786963, 4266.082792199676, 4271.483623313726, 4277.893052673677, 4280.400743895857, 4281.272183728774, 4271.359296105578, 4288.16380805743, 4299.226139294926, 4299.50555686097, 4316.892077698051, 3691.354013047706, 3838.769673819552, 3838.9845331201063, 3842.366009608439, 3843.942340864889, 5310.44240354761, 5320.680759154425, 5323.893522129574, 5329.307190065306, 5340.519353258225, 4861.173600487926, 4865.713114836021, 4874.439439464471, 4903.8528844134735, 4914.655974081816, 5502.367227768817, 5680.375158732536, 5727.885442291173, 5735.193414074553, 5753.309602847643, 4109.890329611018, 4110.301248787713, 4116.794160292004, 4160.356659119661, 4189.790510474494, 5952.255968003999, 6016.187814645011, 6045.153678485016, 6057.121717351003, 6069.0, 4123.525794533607, 4230.8519201827785, 4270.487541494978, 4276.893077673083, 4278.165757677223, 4225.915481690349, 4242.978785106116, 4269.765162916069, 4274.786260686953, 4287.356896465492, 4821.349117869113, 4892.192788189909, 4900.901981960341, 4902.607791376681, 4934.925976110361, 5707.600467967285, 5766.971165144148, 5782.537397008229, 5808.448197421323, 5815.94184058154, 1473.4253641079988, 1475.4909556203309, 1479.408236705305, 1480.9555713328402, 1484.5323723027211, 898.8471959766855, 929.6188562689265, 950.011987532958, 955.5317894231777, 955.5652178258875, 4881.658283920092, 4897.0, 4905.402233995271, 4919.0, 4919.687746759089, 5106.697792063, 5133.537981581676, 5164.0, 5164.664296820694, 5176.792928282902, 4597.977010114928, 4896.632752543574, 4927.457979622239, 4929.852104436801, 4941.654084214142, 2678.7990900682526, 2697.9325516862236, 2702.554078577052, 2753.8433857779783, 2763.9309017274727, 5278.261043453919, 5299.065840968019, 5303.761330740049, 5310.256564081032, 5311.0, 5200.349956255468, 5290.867728306823, 5657.660540367591, 6088.360722124202, 6115.969420152871, 6157.907631385533, 6158.137860699506, 6193.380661933861, 6197.946349120661, 6200.56596038273, 5686.2323586315315, 5924.0, 5928.34788173292, 5980.282366116094, 5980.611260268069, 5839.941600584109, 5910.881782364243, 5941.970290148522, 5942.494887934401, 5978.940210597838, 6203.410675985955, 6217.720202590985, 6223.070848037123, 6224.657643829632, 6259.749610015549, 3817.1602247505502, 3976.701747368901, 4128.91742165161, 4160.583941605815, 4174.519930207944, 5807.535397168132, 5858.2677165354335, 5898.35118136996, 5946.43508866657, 5991.490723288569, 5702.0, 5835.591508594527, 5837.562182836219, 5843.166064458649, 5852.824415267549, 5651.802186923438, 5671.177679236405, 5699.202111704281, 5710.600257981901, 5719.685417302088, 5621.943780562306, 5686.914696279477, 5696.572757043321, 5697.6296540724725, 5726.570507211893, 5608.887822243614, 5796.507296879644, 5799.217105690846, 5825.737841797045, 5828.289845221992, 5706.543476521952, 5733.59864809476, 5752.568557358131, 5752.769889204553, 5767.192593036894], "value": 4299.69306945378, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.8916717908722, 719.8020544350306, 726.5422783646305, 742.8885667149927, 805.367786287764, 14344.211068391234, 15772.290246938886, 15786.921065394685, 15797.36810527579, 15841.28714207862, 13692.657683557916, 13770.793438098437, 13799.379027943742, 13802.65493362664, 13811.65470863229, 660.3297652882304, 677.9830504237384, 773.4044785515135, 782.9530228186327, 796.0248695348181, 801.8476489466983, 802.3500964218972, 803.8553060449117, 803.8713805791075, 804.0391731880405, 852.2457625001856, 852.595017366752, 853.9658413663477, 854.2610641794865, 854.786303424144, 833.7373727275889, 838.714836955432, 843.173689784009, 844.7676888855583, 845.2055068235869, 618.1438707390251, 618.3816183816184, 618.7030225491744, 619.8729260501586, 620.2928661326092, 12848.22910625356, 12894.097413181082, 12925.289109098996, 12929.676758081028, 12950.54673086447, 13998.510052148125, 14008.0194386393, 14243.78634320486, 14285.0, 14295.928520357436, 10926.235163538555, 10991.945040274748, 11050.0, 11123.27698699582, 11231.887681123166, 4295.4201182840225, 4410.669199810027, 4416.955830441687, 4436.73379597222, 4548.953393092126, 72154.27845721527, 72192.639036805, 72225.0, 72880.27119728788, 74159.0, 10498.632547860789, 10515.579376824995, 10575.153987680967, 10765.461726913623, 10775.515101820436, 19976.60046799085, 20042.098105585283, 20110.597788044157, 20146.496337591678, 20705.89647051755, 7769.456138070281, 7859.567723775133, 7970.123286438487, 8099.595020248964, 8129.349652027823, 4294.871153865389, 4460.8661740147845, 4489.551044895549, 4557.498675145731, 4576.58810707038, 3447.0, 3626.9818650906577, 3642.7996460194413, 3657.7805331680183, 3675.650813172798, 610.7434877351523, 615.793709107445, 616.8858761129205, 627.7614506487505, 632.1971096707156, 585.1018686316569, 586.4633860018035, 608.14251904814, 679.3071067511111, 698.678607840389, 8966.625659748475, 9493.145616894375, 9927.453990030474, 10143.23925705575, 10331.32846364984, 669.8124525132971, 672.7040102354948, 693.7710555516668, 696.8641114982631, 709.124231574016, 4338.834718670112, 4362.607365337071, 4737.820343526886, 4806.0, 4828.686135401188, 69613.65193174103, 70540.0, 70577.0, 86770.0, 127165.36417317855, 60825.69587152036, 86693.0, 93146.53426732823, 101532.30846144231, 105191.0, 91025.0, 91625.54187229155, 92080.0, 92697.0, 94664.52667736479, 8711.520866352412, 9270.258379329773, 9333.486658233862, 9391.953040234755, 9424.104710052534, 52532.0, 52848.92237392749, 53287.4671253298, 54457.72771136119, 55056.724716376164, 76371.0, 76931.23068769241, 79637.0, 80256.0, 82296.0, 11628.767424651629, 11764.35296058725, 11857.644270671894, 12001.939990299992, 12115.212511186744, 12815.743685126432, 13259.933700331436, 13751.862481375058, 14651.70696586041, 14695.41218351254, 13607.591772246848, 13614.455421783017, 13823.420687175025, 14048.0, 14501.129932204101, 13158.934205328913, 13412.12821166621, 13471.865281347062, 13560.0, 14030.438782448588, 12482.313472759086, 12628.810567841307, 12678.239305641691, 13472.79790803119, 13775.862241377457, 10325.257582860428, 10470.586470826342, 10536.367817930948, 10614.681559553226, 10914.181436392144, 10092.596296148366, 10234.232432567438, 10410.219233557362, 11112.0, 11460.94269528647], "value": 7290.373250525436, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1502.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 114.0, 114.0, 112.0, 114.0, 113.0, 113.0, 113.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 122.0, 121.0, 165.0, 122.0, 124.0, 121.0, 120.0, 157.0, 131.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 165.0, 173.0, 163.0, 160.0, 163.0, 161.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 119.0, 78.0, 76.0, 77.0, 77.0, 104.0, 76.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 122.0, 82.0, 82.0, 83.0, 99.0, 83.0, 83.0, 123.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 120.0, 118.0, 118.0, 117.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 146.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 51.0, 52.0, 53.0, 54.0, 52.0, 53.0, 52.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 61.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 87.0, 85.0, 81.0, 79.0, 80.0, 82.0, 79.0, 80.0, 80.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 130.0, 134.0, 129.0, 128.0, 138.0, 133.0, 168.0, 126.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 161.0, 164.0, 164.0, 165.0, 162.0, 162.0, 161.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 67.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0], "value": 65.3, "unit": "score"}]}]} 05:21:53 INFO - Return code: 0 05:21:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:21:53 ERROR - # TBPL SUCCESS # 05:21:53 INFO - Running post-action listener: _resource_record_post_action 05:21:53 INFO - [mozharness: 2016-09-29 12:21:53.230675Z] Finished run-tests step (success) 05:21:53 INFO - Running post-run listener: _resource_record_post_run 05:21:53 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403910656; Read time: 8; Write time: 323596 05:21:53 INFO - TinderboxPrint: CPU usage
13.4% 05:21:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:21:53 INFO - TinderboxPrint: I/O write bytes / time
403,910,656 / 323,596 05:21:53 INFO - TinderboxPrint: CPU idle
8,243.1 (86.6%) 05:21:53 INFO - TinderboxPrint: CPU user
1,215.7 (12.8%) 05:21:53 INFO - TinderboxPrint: Swap in / out
0 / 0 05:21:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103948288; Read time: 0; Write time: 67144 05:21:53 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 288550912; Read time: 0; Write time: 254656 05:21:53 INFO - Running post-run listener: _upload_blobber_files 05:21:53 INFO - Blob upload gear active. 05:21:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:21:53 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 05:21:53 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:21:53 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:21:54 INFO - (blobuploader) - INFO - Open directory for files ... 05:21:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:21:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:21:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:55 INFO - (blobuploader) - INFO - Done attempting. 05:21:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:21:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:21:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:58 INFO - (blobuploader) - INFO - Done attempting. 05:21:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:21:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:21:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:59 INFO - (blobuploader) - INFO - Done attempting. 05:21:59 INFO - (blobuploader) - INFO - Iteration through files over. 05:21:59 INFO - Return code: 0 05:21:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:21:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:21:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6e63529fee1c93f435111a9ba318d2611f581078bb52993a1475156bfc5b49720ba43663c314b129c52f20afc3c3692f4dce63d7f29fa294bf14cc78512f989", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc3c2da43ce9f03ca6404e8174860d067945facdc642d9f56f71c818cad8c928044980a935341226a7cb2e9fcc970abb14e266e362e5fc1fccdc44ac1895fef2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/116db25ae749a391d5c1b7349708945cf20a13fc253e8b65e062efa961b710aa00e5f891dccd2018ddf5b4a9930bfe260c51debb988b2c010bfc8d56ba00b803"} 05:21:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:21:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:21:59 INFO - Contents: 05:21:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6e63529fee1c93f435111a9ba318d2611f581078bb52993a1475156bfc5b49720ba43663c314b129c52f20afc3c3692f4dce63d7f29fa294bf14cc78512f989", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc3c2da43ce9f03ca6404e8174860d067945facdc642d9f56f71c818cad8c928044980a935341226a7cb2e9fcc970abb14e266e362e5fc1fccdc44ac1895fef2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/116db25ae749a391d5c1b7349708945cf20a13fc253e8b65e062efa961b710aa00e5f891dccd2018ddf5b4a9930bfe260c51debb988b2c010bfc8d56ba00b803"} 05:21:59 INFO - Running post-run listener: copy_logs_to_upload_dir 05:21:59 INFO - Copying logs to upload dir... 05:21:59 INFO - mkdir: /builds/slave/test/build/upload/logs 05:21:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.035471 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-09-29 05:21:59.099410) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 05:21:59.103184) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088 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/Fx-Team/sha512/f6e63529fee1c93f435111a9ba318d2611f581078bb52993a1475156bfc5b49720ba43663c314b129c52f20afc3c3692f4dce63d7f29fa294bf14cc78512f989", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc3c2da43ce9f03ca6404e8174860d067945facdc642d9f56f71c818cad8c928044980a935341226a7cb2e9fcc970abb14e266e362e5fc1fccdc44ac1895fef2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/116db25ae749a391d5c1b7349708945cf20a13fc253e8b65e062efa961b710aa00e5f891dccd2018ddf5b4a9930bfe260c51debb988b2c010bfc8d56ba00b803"} build_url:https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/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/Fx-Team/sha512/f6e63529fee1c93f435111a9ba318d2611f581078bb52993a1475156bfc5b49720ba43663c314b129c52f20afc3c3692f4dce63d7f29fa294bf14cc78512f989", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc3c2da43ce9f03ca6404e8174860d067945facdc642d9f56f71c818cad8c928044980a935341226a7cb2e9fcc970abb14e266e362e5fc1fccdc44ac1895fef2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/116db25ae749a391d5c1b7349708945cf20a13fc253e8b65e062efa961b710aa00e5f891dccd2018ddf5b4a9930bfe260c51debb988b2c010bfc8d56ba00b803"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 05:21:59.129203) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 05:21:59.129547) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475150478.993240-1873498088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 05:21:59.212995) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 05:21:59.213358) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 05:21:59.213693) ========= ========= Total master_lag: 0.16 =========