builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1475567485.68 results: success (0) buildid: 20161004001902 builduid: 50a13ba6d819450fadd490f7900a21e8 revision: f927dc3ad86478c7b54507fa8cf862cff4f372b4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 00:51:25.675394) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 00:51:25.675864) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 00:51:25.676167) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 00:51:25.690925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:51:25.691219) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 00:51:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 48.6M=0s 2016-10-04 00:51:25 (48.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148966 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:51:25.853264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:51:25.853551) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024039 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:51:25.902789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 00:51:25.903175) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f927dc3ad86478c7b54507fa8cf862cff4f372b4 --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 f927dc3ad86478c7b54507fa8cf862cff4f372b4 --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=5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 00:51:26,001 truncating revision to first 12 chars 2016-10-04 00:51:26,001 Setting DEBUG logging. 2016-10-04 00:51:26,001 attempt 1/10 2016-10-04 00:51:26,001 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f927dc3ad864?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 00:51:26,992 unpacking tar archive at: fx-team-f927dc3ad864/testing/mozharness/ program finished with exit code 0 elapsedTime=1.310954 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 00:51:27.228026) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 00:51:27.228386) ========= script_repo_revision: f927dc3ad86478c7b54507fa8cf862cff4f372b4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 00:51:27.228854) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 00:51:27.229124) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 00:51:27.237934) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-04 00:51:27.238252) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:51:27 INFO - MultiFileLogger online at 20161004 00:51:27 in /builds/slave/test 00:51:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 00:51:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:51:27 INFO - {'append_to_log': False, 00:51:27 INFO - 'base_work_dir': '/builds/slave/test', 00:51:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:51:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:51:27 INFO - 'branch': 'Fx-Team-Non-PGO', 00:51:27 INFO - 'buildbot_json_path': 'buildprops.json', 00:51:27 INFO - 'config_files': ('talos/linux_config.py',), 00:51:27 INFO - 'default_actions': ('clobber', 00:51:27 INFO - 'read-buildbot-config', 00:51:27 INFO - 'download-and-extract', 00:51:27 INFO - 'populate-webroot', 00:51:27 INFO - 'create-virtualenv', 00:51:27 INFO - 'install', 00:51:27 INFO - 'run-tests'), 00:51:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:51:27 INFO - 'download_minidump_stackwalk': True, 00:51:27 INFO - 'download_symbols': 'ondemand', 00:51:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:51:27 INFO - 'tooltool.py': '/tools/tooltool.py', 00:51:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:51:27 INFO - '/tools/misc-python/virtualenv.py')}, 00:51:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:51:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:51:27 INFO - 'installer_path': 'installer.exe', 00:51:27 INFO - 'log_level': 'info', 00:51:27 INFO - 'log_name': 'talos', 00:51:27 INFO - 'log_to_console': True, 00:51:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:51:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:51:27 INFO - 'opt_config_files': (), 00:51:27 INFO - 'pip_index': False, 00:51:27 INFO - 'sps_profile': False, 00:51:27 INFO - 'sps_profile_interval': 0, 00:51:27 INFO - 'suite': 'dromaeojs', 00:51:27 INFO - 'system_bits': '32', 00:51:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:51:27 INFO - 'title': 'talos-linux64-ix-051', 00:51:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:51:27 INFO - 'use_talos_json': True, 00:51:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:51:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:51:27 INFO - 'work_dir': 'build'} 00:51:27 INFO - [mozharness: 2016-10-04 07:51:27.434329Z] Running clobber step. 00:51:27 INFO - Running pre-action listener: _resource_record_pre_action 00:51:27 INFO - Running main action method: clobber 00:51:27 INFO - rmtree: /builds/slave/test/build 00:51:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:51:28 INFO - Running post-action listener: _resource_record_post_action 00:51:28 INFO - [mozharness: 2016-10-04 07:51:28.392139Z] Finished clobber step (success) 00:51:28 INFO - [mozharness: 2016-10-04 07:51:28.392238Z] Running read-buildbot-config step. 00:51:28 INFO - Running pre-action listener: _resource_record_pre_action 00:51:28 INFO - Running main action method: read_buildbot_config 00:51:28 INFO - Using buildbot properties: 00:51:28 INFO - { 00:51:28 INFO - "project": "", 00:51:28 INFO - "product": "firefox", 00:51:28 INFO - "script_repo_revision": "production", 00:51:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:51:28 INFO - "repository": "", 00:51:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 00:51:28 INFO - "buildid": "20161004001902", 00:51:28 INFO - "pgo_build": "False", 00:51:28 INFO - "basedir": "/builds/slave/test", 00:51:28 INFO - "buildnumber": 2192, 00:51:28 INFO - "slavename": "talos-linux64-ix-051", 00:51:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:51:28 INFO - "platform": "ubuntu64_hw", 00:51:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:51:28 INFO - "branch": "fx-team", 00:51:28 INFO - "repo_path": "integration/fx-team", 00:51:28 INFO - "revision": "f927dc3ad86478c7b54507fa8cf862cff4f372b4", 00:51:28 INFO - "stage_platform": "linux64", 00:51:28 INFO - "builduid": "50a13ba6d819450fadd490f7900a21e8", 00:51:28 INFO - "slavebuilddir": "test" 00:51:28 INFO - } 00:51:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 00:51:28 INFO - Running post-action listener: _resource_record_post_action 00:51:28 INFO - [mozharness: 2016-10-04 07:51:28.394668Z] Finished read-buildbot-config step (success) 00:51:28 INFO - [mozharness: 2016-10-04 07:51:28.394756Z] Running download-and-extract step. 00:51:28 INFO - Running pre-action listener: _resource_record_pre_action 00:51:28 INFO - Running main action method: download_and_extract 00:51:28 INFO - mkdir: /builds/slave/test/build/tests 00:51:28 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')]} 00:51:28 INFO - trying https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:51:28 INFO - Downloading https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/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 00:51:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/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 00:51:28 INFO - Downloaded 1361 bytes. 00:51:28 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:51:28 INFO - Using the following test package requirements: 00:51:28 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:51:28 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:51:28 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:51:28 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:28 INFO - u'jsshell-linux-x86_64.zip'], 00:51:28 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:51:28 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:51:28 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:51:28 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:51:28 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:51:28 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:51:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:51:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:51:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:51:28 INFO - Fetch https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:51:29 INFO - Http code: 200 00:51:29 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 00:51:29 INFO - x-amz-cf-id: ZAf8G3Zf0C6o6lI2BjR_lViSekTBQeAE450XNPjN1XHbZWdu4eDb9Q== 00:51:29 INFO - x-amz-version-id: 7ileq31UMo_lFMyTLaAZrZ3tKF7BABQH 00:51:29 INFO - Expected file size: 20420910 00:51:29 INFO - Obtained file size: 20420910 00:51:33 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 00:51:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:51:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:51:33 INFO - Fetch https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:51:34 INFO - Http code: 200 00:51:34 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 00:51:34 INFO - x-amz-cf-id: y3E8t6aT3pOv3BlKctoQxAb26NMEMeLQEA0yUzcDsiXTBiEyGNsG1Q== 00:51:34 INFO - x-amz-version-id: 7ileq31UMo_lFMyTLaAZrZ3tKF7BABQH 00:51:34 INFO - Expected file size: 20420910 00:51:34 INFO - Obtained file size: 20420910 00:51:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 00:51:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:51:39 INFO - Fetch https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:51:39 INFO - Http code: 200 00:51:39 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 00:51:39 INFO - x-amz-cf-id: srO_X783lKp9Ug74Jfzc_JYUi8A0I_juWs2YT4zR5IP1Gk_EJAziQQ== 00:51:39 INFO - x-amz-version-id: KimhQsvMCAkRKERdgpmNFHV2JCxfN0PF 00:51:39 INFO - Expected file size: 14409006 00:51:39 INFO - Obtained file size: 14409006 00:51: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')]} 00:51:40 INFO - trying https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:51:40 INFO - Downloading https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/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 00:51:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/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 00:51:41 INFO - Downloaded 55792524 bytes. 00:51:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:51:41 INFO - mkdir: /builds/slave/test/properties 00:51:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:51:41 INFO - Writing to file /builds/slave/test/properties/build_url 00:51:41 INFO - Contents: 00:51:41 INFO - build_url:https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:51:41 INFO - Running post-action listener: _resource_record_post_action 00:51:41 INFO - Running post-action listener: set_extra_try_arguments 00:51:41 INFO - [mozharness: 2016-10-04 07:51:41.883453Z] Finished download-and-extract step (success) 00:51:41 INFO - [mozharness: 2016-10-04 07:51:41.883679Z] Running populate-webroot step. 00:51:41 INFO - Running pre-action listener: _resource_record_pre_action 00:51:41 INFO - Running main action method: populate_webroot 00:51:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:51:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:51:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:51:41 INFO - '--tppagecycles', 00:51:41 INFO - '7'], 00:51:41 INFO - 'tests': ['tsvgm']}}, 00:51:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:51:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:51:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:51:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:51:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:51:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:51:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:41 INFO - 'talos_options': ['--disable-e10s'], 00:51:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:51:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:51:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:41 INFO - 'talos_options': ['--disable-e10s'], 00:51:41 INFO - 'tests': ['damp', 'tps']}, 00:51:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:41 INFO - 'tests': ['damp', 'tps']}, 00:51:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:51:41 INFO - 'tests': ['dromaeo_dom']}, 00:51:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:51:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:51:41 INFO - 'tests': ['basic_compositor_video']}, 00:51:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:51:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:51:41 INFO - 'tests': ['a11yr', 00:51:41 INFO - 'ts_paint', 00:51:41 INFO - 'tpaint', 00:51:41 INFO - 'sessionrestore', 00:51:41 INFO - 'sessionrestore_no_auto_restore', 00:51:41 INFO - 'tabpaint']}, 00:51:41 INFO - 'other-e10s': {'tests': ['a11yr', 00:51:41 INFO - 'ts_paint', 00:51:41 INFO - 'tpaint', 00:51:41 INFO - 'sessionrestore', 00:51:41 INFO - 'sessionrestore_no_auto_restore', 00:51:41 INFO - 'tabpaint']}, 00:51:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:51:41 INFO - 'ts_paint', 00:51:41 INFO - 'tpaint', 00:51:41 INFO - 'sessionrestore', 00:51:41 INFO - 'sessionrestore_no_auto_restore', 00:51:41 INFO - 'tabpaint']}, 00:51:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:51:41 INFO - 'ts_paint', 00:51:41 INFO - 'tpaint', 00:51:41 INFO - 'sessionrestore', 00:51:41 INFO - 'sessionrestore_no_auto_restore', 00:51:41 INFO - 'tabpaint']}, 00:51:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:51:41 INFO - 'tests': ['a11yr', 00:51:41 INFO - 'ts_paint', 00:51:41 INFO - 'tpaint', 00:51:41 INFO - 'sessionrestore', 00:51:41 INFO - 'sessionrestore_no_auto_restore', 00:51:41 INFO - 'tabpaint']}, 00:51:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:51:41 INFO - 'tests': ['a11yr', 00:51:41 INFO - 'ts_paint', 00:51:41 INFO - 'tpaint', 00:51:41 INFO - 'sessionrestore', 00:51:41 INFO - 'sessionrestore_no_auto_restore', 00:51:41 INFO - 'tabpaint']}, 00:51:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:51:41 INFO - 'tests': ['tsvgx', 00:51:41 INFO - 'tsvgr_opacity', 00:51:41 INFO - 'tart', 00:51:41 INFO - 'tscrollx', 00:51:41 INFO - 'cart']}, 00:51:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:51:41 INFO - 'tsvgr_opacity', 00:51:41 INFO - 'tart', 00:51:41 INFO - 'tscrollx', 00:51:41 INFO - 'cart']}, 00:51:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:41 INFO - 'talos_options': ['--disable-e10s'], 00:51:41 INFO - 'tests': ['tp5o']}, 00:51:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:41 INFO - 'tests': ['tp5o']}, 00:51:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:41 INFO - 'talos_options': ['--disable-e10s', 00:51:41 INFO - '--xperf_path', 00:51:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:51:41 INFO - 'tests': ['tp5n']}, 00:51:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:41 INFO - 'talos_options': ['--xperf_path', 00:51:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:51:41 INFO - 'tests': ['tp5n']}}, 00:51:41 INFO - 'talos.zip': {'path': '', 00:51:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:51:41 INFO - Running post-action listener: _resource_record_post_action 00:51:41 INFO - [mozharness: 2016-10-04 07:51:41.900315Z] Finished populate-webroot step (success) 00:51:41 INFO - [mozharness: 2016-10-04 07:51:41.900403Z] Running create-virtualenv step. 00:51:41 INFO - Running pre-action listener: _resource_record_pre_action 00:51:41 INFO - Running main action method: create_virtualenv 00:51:41 INFO - Creating virtualenv /builds/slave/test/build/venv 00:51:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:51:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:51:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:51:42 INFO - Using real prefix '/usr' 00:51:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:51:42 INFO - Installing distribute.............................................................................................................................................................................................done. 00:51:44 INFO - Installing pip.................done. 00:51:44 INFO - Return code: 0 00:51:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:51:44 INFO - Reading from file tmpfile_stdout 00:51:44 INFO - Output received: 00:51:44 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 00:51:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6acd66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82f60>, '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 0xe83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe841d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', '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 00:51:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:51:44 INFO - Using env: {'DISPLAY': ':0', 00:51:44 INFO - 'HOME': '/home/cltbld', 00:51:44 INFO - 'LANG': 'en_US.UTF-8', 00:51:44 INFO - 'LANGUAGE': 'en_US:en', 00:51:44 INFO - 'LOGNAME': 'cltbld', 00:51:44 INFO - 'MAIL': '/var/mail/cltbld', 00:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:44 INFO - 'MOZ_NO_REMOTE': '1', 00:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:44 INFO - 'NO_EM_RESTART': '1', 00:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:44 INFO - 'PWD': '/builds/slave/test', 00:51:44 INFO - 'SHELL': '/bin/bash', 00:51:44 INFO - 'SHLVL': '1', 00:51:44 INFO - 'TERM': 'linux', 00:51:44 INFO - 'TMOUT': '86400', 00:51:44 INFO - 'USER': 'cltbld', 00:51:44 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', 00:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:44 INFO - '_': '/tools/buildbot/bin/python'} 00:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:51:44 INFO - Cleaning up... 00:51:44 INFO - Return code: 0 00:51:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6acd66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82f60>, '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 0xe83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe841d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', '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 00:51:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:51:44 INFO - Using env: {'DISPLAY': ':0', 00:51:44 INFO - 'HOME': '/home/cltbld', 00:51:44 INFO - 'LANG': 'en_US.UTF-8', 00:51:44 INFO - 'LANGUAGE': 'en_US:en', 00:51:44 INFO - 'LOGNAME': 'cltbld', 00:51:44 INFO - 'MAIL': '/var/mail/cltbld', 00:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:44 INFO - 'MOZ_NO_REMOTE': '1', 00:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:44 INFO - 'NO_EM_RESTART': '1', 00:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:44 INFO - 'PWD': '/builds/slave/test', 00:51:44 INFO - 'SHELL': '/bin/bash', 00:51:44 INFO - 'SHLVL': '1', 00:51:44 INFO - 'TERM': 'linux', 00:51:44 INFO - 'TMOUT': '86400', 00:51:44 INFO - 'USER': 'cltbld', 00:51:44 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', 00:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:44 INFO - '_': '/tools/buildbot/bin/python'} 00:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:45 INFO - Downloading/unpacking psutil>=3.1.1 00:51: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 00:51: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 00:51: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 00:51: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 00:51: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 00:51: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 00:51:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:51:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:51:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:51:47 INFO - Installing collected packages: psutil 00:51:47 INFO - Running setup.py install for psutil 00:51:47 INFO - building 'psutil._psutil_linux' extension 00:51:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 00:51:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:51:47 INFO - building 'psutil._psutil_posix' extension 00:51:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:51:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:51:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:51:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:51:47 INFO - Successfully installed psutil 00:51:47 INFO - Cleaning up... 00:51:47 INFO - Return code: 0 00:51:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:51: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')]} 00:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51: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')]} 00:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6acd66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82f60>, '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 0xe83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe841d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', '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 00:51: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:51: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 mozsystemmonitor==0.3 00:51:47 INFO - Using env: {'DISPLAY': ':0', 00:51:47 INFO - 'HOME': '/home/cltbld', 00:51:47 INFO - 'LANG': 'en_US.UTF-8', 00:51:47 INFO - 'LANGUAGE': 'en_US:en', 00:51:47 INFO - 'LOGNAME': 'cltbld', 00:51:47 INFO - 'MAIL': '/var/mail/cltbld', 00:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:47 INFO - 'MOZ_NO_REMOTE': '1', 00:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:47 INFO - 'NO_EM_RESTART': '1', 00:51:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:47 INFO - 'PWD': '/builds/slave/test', 00:51:47 INFO - 'SHELL': '/bin/bash', 00:51:47 INFO - 'SHLVL': '1', 00:51:47 INFO - 'TERM': 'linux', 00:51:47 INFO - 'TMOUT': '86400', 00:51:47 INFO - 'USER': 'cltbld', 00:51:47 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', 00:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:47 INFO - '_': '/tools/buildbot/bin/python'} 00:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:51: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 00:51: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 00:51: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 00:51: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 00:51: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 00:51: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 00:51:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:51:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:51:49 INFO - Installing collected packages: mozsystemmonitor 00:51:49 INFO - Running setup.py install for mozsystemmonitor 00:51:49 INFO - Successfully installed mozsystemmonitor 00:51:49 INFO - Cleaning up... 00:51:50 INFO - Return code: 0 00:51:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:51:50 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')]} 00:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:50 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')]} 00:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:50 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 0x7fa6acd66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82f60>, '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 0xe83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe841d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', '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 00:51:50 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 00:51:50 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 00:51:50 INFO - Using env: {'DISPLAY': ':0', 00:51:50 INFO - 'HOME': '/home/cltbld', 00:51:50 INFO - 'LANG': 'en_US.UTF-8', 00:51:50 INFO - 'LANGUAGE': 'en_US:en', 00:51:50 INFO - 'LOGNAME': 'cltbld', 00:51:50 INFO - 'MAIL': '/var/mail/cltbld', 00:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:50 INFO - 'MOZ_NO_REMOTE': '1', 00:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:50 INFO - 'NO_EM_RESTART': '1', 00:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:50 INFO - 'PWD': '/builds/slave/test', 00:51:50 INFO - 'SHELL': '/bin/bash', 00:51:50 INFO - 'SHLVL': '1', 00:51:50 INFO - 'TERM': 'linux', 00:51:50 INFO - 'TMOUT': '86400', 00:51:50 INFO - 'USER': 'cltbld', 00:51:50 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', 00:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:50 INFO - '_': '/tools/buildbot/bin/python'} 00:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:50 INFO - Downloading/unpacking jsonschema==2.5.1 00:51: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 00:51: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 00:51: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 00:51: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 00:51: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 00:51: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 00:51:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:51:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:52 INFO - Downloading functools32-3.2.3-2.tar.gz 00:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:51:52 INFO - warning: no files found matching '*.txt' 00:51:52 INFO - no previously-included directories found matching 'build' 00:51:52 INFO - no previously-included directories found matching 'dist' 00:51:52 INFO - no previously-included directories found matching '.git*' 00:51:52 INFO - Installing collected packages: jsonschema, functools32 00:51:52 INFO - Running setup.py install for functools32 00:51:52 INFO - warning: no files found matching '*.txt' 00:51:52 INFO - no previously-included directories found matching 'build' 00:51:52 INFO - no previously-included directories found matching 'dist' 00:51:52 INFO - no previously-included directories found matching '.git*' 00:51:52 INFO - Successfully installed jsonschema functools32 00:51:52 INFO - Cleaning up... 00:51:52 INFO - Return code: 0 00:51:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa6acd66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82f60>, '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 0xe83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe841d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', '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 00:51:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:51:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:51:52 INFO - Using env: {'DISPLAY': ':0', 00:51:52 INFO - 'HOME': '/home/cltbld', 00:51:52 INFO - 'LANG': 'en_US.UTF-8', 00:51:52 INFO - 'LANGUAGE': 'en_US:en', 00:51:52 INFO - 'LOGNAME': 'cltbld', 00:51:52 INFO - 'MAIL': '/var/mail/cltbld', 00:51:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:52 INFO - 'MOZ_NO_REMOTE': '1', 00:51:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:52 INFO - 'NO_EM_RESTART': '1', 00:51:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:52 INFO - 'PWD': '/builds/slave/test', 00:51:52 INFO - 'SHELL': '/bin/bash', 00:51:52 INFO - 'SHLVL': '1', 00:51:52 INFO - 'TERM': 'linux', 00:51:52 INFO - 'TMOUT': '86400', 00:51:52 INFO - 'USER': 'cltbld', 00:51:52 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', 00:51:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:52 INFO - '_': '/tools/buildbot/bin/python'} 00:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:51:52 INFO - Cleaning up... 00:51:52 INFO - Return code: 0 00:51:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa6acd66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82f60>, '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 0xe83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe841d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', '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 00:51:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:51:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:51:52 INFO - Using env: {'DISPLAY': ':0', 00:51:52 INFO - 'HOME': '/home/cltbld', 00:51:52 INFO - 'LANG': 'en_US.UTF-8', 00:51:52 INFO - 'LANGUAGE': 'en_US:en', 00:51:52 INFO - 'LOGNAME': 'cltbld', 00:51:52 INFO - 'MAIL': '/var/mail/cltbld', 00:51:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:52 INFO - 'MOZ_NO_REMOTE': '1', 00:51:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:52 INFO - 'NO_EM_RESTART': '1', 00:51:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:52 INFO - 'PWD': '/builds/slave/test', 00:51:52 INFO - 'SHELL': '/bin/bash', 00:51:52 INFO - 'SHLVL': '1', 00:51:52 INFO - 'TERM': 'linux', 00:51:52 INFO - 'TMOUT': '86400', 00:51:52 INFO - 'USER': 'cltbld', 00:51:52 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', 00:51:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:52 INFO - '_': '/tools/buildbot/bin/python'} 00:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:53 INFO - Downloading/unpacking blobuploader==1.2.4 00:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:54 INFO - Downloading blobuploader-1.2.4.tar.gz 00:51:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:51:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:51:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:55 INFO - Downloading docopt-0.6.1.tar.gz 00:51:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:51:55 INFO - Installing collected packages: blobuploader, requests, docopt 00:51:55 INFO - Running setup.py install for blobuploader 00:51:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:51:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:51:55 INFO - Running setup.py install for requests 00:51:56 INFO - Running setup.py install for docopt 00:51:56 INFO - Successfully installed blobuploader requests docopt 00:51:56 INFO - Cleaning up... 00:51:56 INFO - Return code: 0 00:51:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:56 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 0x7fa6acd66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82f60>, '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 0xe83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe841d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', '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 00:51:56 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 00:51:56 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 00:51:56 INFO - Using env: {'DISPLAY': ':0', 00:51:56 INFO - 'HOME': '/home/cltbld', 00:51:56 INFO - 'LANG': 'en_US.UTF-8', 00:51:56 INFO - 'LANGUAGE': 'en_US:en', 00:51:56 INFO - 'LOGNAME': 'cltbld', 00:51:56 INFO - 'MAIL': '/var/mail/cltbld', 00:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:56 INFO - 'MOZ_NO_REMOTE': '1', 00:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:56 INFO - 'NO_EM_RESTART': '1', 00:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:56 INFO - 'PWD': '/builds/slave/test', 00:51:56 INFO - 'SHELL': '/bin/bash', 00:51:56 INFO - 'SHLVL': '1', 00:51:56 INFO - 'TERM': 'linux', 00:51:56 INFO - 'TMOUT': '86400', 00:51:56 INFO - 'USER': 'cltbld', 00:51:56 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', 00:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:56 INFO - '_': '/tools/buildbot/bin/python'} 00:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:51:56 INFO - Running setup.py (path:/tmp/pip-Rp3BVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:51:56 INFO - Running setup.py (path:/tmp/pip-w73pHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:51:56 INFO - Running setup.py (path:/tmp/pip-GiS6qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:51:56 INFO - Running setup.py (path:/tmp/pip-v5W0UE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:51:56 INFO - Running setup.py (path:/tmp/pip-6Di34A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:51:56 INFO - Running setup.py (path:/tmp/pip-5mYWzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:51:57 INFO - Running setup.py (path:/tmp/pip-yz6R3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:51:57 INFO - Running setup.py (path:/tmp/pip-kstGlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:51:57 INFO - Running setup.py (path:/tmp/pip-BKO2Kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:51:57 INFO - Running setup.py (path:/tmp/pip-FBE0ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:51:57 INFO - Running setup.py (path:/tmp/pip-DIDgVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:51:57 INFO - Running setup.py (path:/tmp/pip-F1Vv11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:51:57 INFO - Running setup.py (path:/tmp/pip-u6BGHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:51:57 INFO - Running setup.py (path:/tmp/pip-m7QkEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:51:57 INFO - Running setup.py (path:/tmp/pip-c6C7i0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:51:57 INFO - Running setup.py (path:/tmp/pip-3S0VQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:51:57 INFO - Running setup.py (path:/tmp/pip-pWfzbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:51:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:51:57 INFO - Running setup.py install for manifestparser 00:51:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:51:57 INFO - Running setup.py install for mozcrash 00:51:57 INFO - Running setup.py install for mozdebug 00:51:58 INFO - Running setup.py install for mozdevice 00:51:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:51:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:51:58 INFO - Running setup.py install for mozfile 00:51:58 INFO - Running setup.py install for mozhttpd 00:51:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:51:58 INFO - Running setup.py install for mozinfo 00:51:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:51:58 INFO - Running setup.py install for mozInstall 00:51:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:51:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:51:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:51:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:51:58 INFO - Running setup.py install for mozleak 00:51:58 INFO - Running setup.py install for mozlog 00:51:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:51:58 INFO - Running setup.py install for moznetwork 00:51:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:51:58 INFO - Running setup.py install for mozprocess 00:51:59 INFO - Running setup.py install for mozprofile 00:51:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:51:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:51:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:51:59 INFO - Running setup.py install for mozrunner 00:51:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:51:59 INFO - Running setup.py install for mozscreenshot 00:51:59 INFO - Running setup.py install for moztest 00:51:59 INFO - Running setup.py install for mozversion 00:51:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:51:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:51:59 INFO - Cleaning up... 00:51:59 INFO - Return code: 0 00:51:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:59 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 0x7fa6acd66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82f60>, '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 0xe83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe841d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', '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 00:51:59 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 00:51:59 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 00:51:59 INFO - Using env: {'DISPLAY': ':0', 00:51:59 INFO - 'HOME': '/home/cltbld', 00:51:59 INFO - 'LANG': 'en_US.UTF-8', 00:51:59 INFO - 'LANGUAGE': 'en_US:en', 00:51:59 INFO - 'LOGNAME': 'cltbld', 00:51:59 INFO - 'MAIL': '/var/mail/cltbld', 00:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:59 INFO - 'MOZ_NO_REMOTE': '1', 00:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:59 INFO - 'NO_EM_RESTART': '1', 00:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:59 INFO - 'PWD': '/builds/slave/test', 00:51:59 INFO - 'SHELL': '/bin/bash', 00:51:59 INFO - 'SHLVL': '1', 00:51:59 INFO - 'TERM': 'linux', 00:51:59 INFO - 'TMOUT': '86400', 00:51:59 INFO - 'USER': 'cltbld', 00:51:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', 00:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:59 INFO - '_': '/tools/buildbot/bin/python'} 00:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:51:59 INFO - Running setup.py (path:/tmp/pip-TeldeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:51:59 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)) 00:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:51:59 INFO - Running setup.py (path:/tmp/pip-OqAQVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:51:59 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)) 00:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:51:59 INFO - Running setup.py (path:/tmp/pip-0OSGu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:52:00 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)) 00:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:52:00 INFO - Running setup.py (path:/tmp/pip-O4f42v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:52:00 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)) 00:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:52:00 INFO - Running setup.py (path:/tmp/pip-bZOM52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:52:00 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)) 00:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:52:00 INFO - Running setup.py (path:/tmp/pip-0WyvDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:52:00 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)) 00:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:52:00 INFO - Running setup.py (path:/tmp/pip-AP2WEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:52:00 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)) 00:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:52:00 INFO - Running setup.py (path:/tmp/pip-M1Pc0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:52:00 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)) 00:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:52:00 INFO - Running setup.py (path:/tmp/pip-Ho_I4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:52:00 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)) 00:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:52:00 INFO - Running setup.py (path:/tmp/pip-79NKZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:52:00 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)) 00:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:52:00 INFO - Running setup.py (path:/tmp/pip-wyet5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:52:00 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)) 00:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:52:00 INFO - Running setup.py (path:/tmp/pip-AAaXqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:52:00 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)) 00:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:52:00 INFO - Running setup.py (path:/tmp/pip-WgEbUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:52:00 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)) 00:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:52:00 INFO - Running setup.py (path:/tmp/pip-viQp6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:52:00 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)) 00:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:52:00 INFO - Running setup.py (path:/tmp/pip-bQzqTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:52:00 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)) 00:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:52:00 INFO - Running setup.py (path:/tmp/pip-G_qlJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:52:01 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)) 00:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:52:01 INFO - Running setup.py (path:/tmp/pip-P_WsKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:52:01 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)) 00:52:01 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)) 00:52:01 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)) 00:52:01 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)) 00:52:01 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)) 00:52:01 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)) 00:52:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:52:01 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 00:52:01 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 00:52:01 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 00:52:01 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 00:52:01 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 00:52:01 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 00:52:03 INFO - Downloading blessings-1.6.tar.gz 00:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:52:03 INFO - Installing collected packages: blessings 00:52:03 INFO - Running setup.py install for blessings 00:52:03 INFO - Successfully installed blessings 00:52:03 INFO - Cleaning up... 00:52:03 INFO - Return code: 0 00:52:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:52:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:52:03 INFO - Reading from file tmpfile_stdout 00:52:03 INFO - Current package versions: 00:52:03 INFO - argparse == 1.2.1 00:52:03 INFO - blessings == 1.6 00:52:03 INFO - blobuploader == 1.2.4 00:52:03 INFO - docopt == 0.6.1 00:52:03 INFO - functools32 == 3.2.3-2 00:52:03 INFO - jsonschema == 2.5.1 00:52:03 INFO - manifestparser == 1.1 00:52:03 INFO - mozInstall == 1.12 00:52:03 INFO - mozcrash == 0.17 00:52:03 INFO - mozdebug == 0.1 00:52:03 INFO - mozdevice == 0.48 00:52:03 INFO - mozfile == 1.2 00:52:03 INFO - mozhttpd == 0.7 00:52:03 INFO - mozinfo == 0.9 00:52:03 INFO - mozleak == 0.1 00:52:03 INFO - mozlog == 3.4 00:52:03 INFO - moznetwork == 0.27 00:52:03 INFO - mozprocess == 0.23 00:52:03 INFO - mozprofile == 0.28 00:52:03 INFO - mozrunner == 6.12 00:52:03 INFO - mozscreenshot == 0.1 00:52:03 INFO - mozsystemmonitor == 0.3 00:52:03 INFO - moztest == 0.7 00:52:03 INFO - mozversion == 1.4 00:52:03 INFO - psutil == 3.1.1 00:52:03 INFO - requests == 1.2.3 00:52:03 INFO - wsgiref == 0.1.2 00:52:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:03 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 0x7fa6acd66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82f60>, '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 0xe83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe841d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', '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 00:52:03 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 00:52:03 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 00:52:03 INFO - Using env: {'DISPLAY': ':0', 00:52:03 INFO - 'HOME': '/home/cltbld', 00:52:03 INFO - 'LANG': 'en_US.UTF-8', 00:52:03 INFO - 'LANGUAGE': 'en_US:en', 00:52:03 INFO - 'LOGNAME': 'cltbld', 00:52:03 INFO - 'MAIL': '/var/mail/cltbld', 00:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:03 INFO - 'MOZ_NO_REMOTE': '1', 00:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:52:03 INFO - 'NO_EM_RESTART': '1', 00:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:03 INFO - 'PWD': '/builds/slave/test', 00:52:03 INFO - 'SHELL': '/bin/bash', 00:52:03 INFO - 'SHLVL': '1', 00:52:03 INFO - 'TERM': 'linux', 00:52:03 INFO - 'TMOUT': '86400', 00:52:03 INFO - 'USER': 'cltbld', 00:52:03 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', 00:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:03 INFO - '_': '/tools/buildbot/bin/python'} 00:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:03 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)) 00:52:03 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)) 00:52:03 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)) 00:52:03 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)) 00:52:03 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)) 00:52:03 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)) 00:52:03 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)) 00:52:03 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)) 00:52:03 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)) 00:52:03 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)) 00:52:03 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)) 00:52:03 INFO - Cleaning up... 00:52:03 INFO - Return code: 0 00:52:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:03 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 0x7fa6acd66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe82f60>, '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 0xe83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe841d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', '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 00:52:03 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 00:52:03 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 00:52:03 INFO - Using env: {'DISPLAY': ':0', 00:52:03 INFO - 'HOME': '/home/cltbld', 00:52:03 INFO - 'LANG': 'en_US.UTF-8', 00:52:03 INFO - 'LANGUAGE': 'en_US:en', 00:52:03 INFO - 'LOGNAME': 'cltbld', 00:52:03 INFO - 'MAIL': '/var/mail/cltbld', 00:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:03 INFO - 'MOZ_NO_REMOTE': '1', 00:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:52:03 INFO - 'NO_EM_RESTART': '1', 00:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:03 INFO - 'PWD': '/builds/slave/test', 00:52:03 INFO - 'SHELL': '/bin/bash', 00:52:03 INFO - 'SHLVL': '1', 00:52:03 INFO - 'TERM': 'linux', 00:52:03 INFO - 'TMOUT': '86400', 00:52:03 INFO - 'USER': 'cltbld', 00:52:03 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', 00:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:03 INFO - '_': '/tools/buildbot/bin/python'} 00:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:52:03 INFO - Cleaning up... 00:52:03 INFO - Return code: 0 00:52:03 INFO - Running post-action listener: _resource_record_post_action 00:52:03 INFO - Running post-action listener: _start_resource_monitoring 00:52:03 INFO - Starting resource monitoring. 00:52:03 INFO - [mozharness: 2016-10-04 07:52:03.986042Z] Finished create-virtualenv step (success) 00:52:03 INFO - [mozharness: 2016-10-04 07:52:03.986500Z] Running install step. 00:52:03 INFO - Running pre-action listener: _resource_record_pre_action 00:52:03 INFO - Running main action method: install 00:52:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:52:04 INFO - Reading from file tmpfile_stdout 00:52:04 INFO - Detecting whether we're running mozinstall >=1.0... 00:52:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:52:04 INFO - Reading from file tmpfile_stdout 00:52:04 INFO - Output received: 00:52:04 INFO - Usage: mozinstall [options] installer 00:52:04 INFO - Options: 00:52:04 INFO - -h, --help show this help message and exit 00:52:04 INFO - -d DEST, --destination=DEST 00:52:04 INFO - Directory to install application into. [default: 00:52:04 INFO - "/builds/slave/test"] 00:52:04 INFO - --app=APP Application being installed. [default: firefox] 00:52:04 INFO - mkdir: /builds/slave/test/build/application 00:52:04 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'] 00:52:04 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 00:52:20 INFO - Reading from file tmpfile_stdout 00:52:20 INFO - Output received: 00:52:20 INFO - /builds/slave/test/build/application/firefox/firefox 00:52:20 INFO - Running post-action listener: _resource_record_post_action 00:52:20 INFO - [mozharness: 2016-10-04 07:52:20.408304Z] Finished install step (success) 00:52:20 INFO - [mozharness: 2016-10-04 07:52:20.408549Z] Running run-tests step. 00:52:20 INFO - Running pre-action listener: _resource_record_pre_action 00:52:20 INFO - Running main action method: run_tests 00:52:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:52:20 INFO - Python 2.7.3 00:52:20 INFO - Return code: 0 00:52:20 INFO - grabbing minidump binary from tooltool 00:52:20 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')]} 00:52:20 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 0xe82f60>, '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 0xe83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe841d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:52:20 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 00:52:20 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 00:52:20 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 00:52:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:52:20 INFO - Return code: 0 00:52:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:52:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:52:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:52:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:52:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:52:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:52:20 INFO - Using env: {'DISPLAY': ':0', 00:52:20 INFO - 'HOME': '/home/cltbld', 00:52:20 INFO - 'LANG': 'en_US.UTF-8', 00:52:20 INFO - 'LANGUAGE': 'en_US:en', 00:52:20 INFO - 'LOGNAME': 'cltbld', 00:52:20 INFO - 'MAIL': '/var/mail/cltbld', 00:52:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:52:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:20 INFO - 'MOZ_NO_REMOTE': '1', 00:52:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:52:20 INFO - 'NO_EM_RESTART': '1', 00:52:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:20 INFO - 'PWD': '/builds/slave/test', 00:52:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:52:20 INFO - 'SHELL': '/bin/bash', 00:52:20 INFO - 'SHLVL': '1', 00:52:20 INFO - 'TERM': 'linux', 00:52:20 INFO - 'TMOUT': '86400', 00:52:20 INFO - 'USER': 'cltbld', 00:52:20 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550', 00:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:20 INFO - '_': '/tools/buildbot/bin/python'} 00:52:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:52:20 INFO - mozversion application_buildid: 20161004001902 00:52:20 INFO - mozversion application_changeset: f927dc3ad86478c7b54507fa8cf862cff4f372b4 00:52:20 INFO - mozversion application_display_name: Nightly 00:52:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:52:20 INFO - mozversion application_name: Firefox 00:52:20 INFO - mozversion application_remotingname: firefox 00:52:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:52:20 INFO - mozversion application_vendor: Mozilla 00:52:20 INFO - mozversion application_version: 52.0a1 00:52:20 INFO - mozversion platform_buildid: 20161004001902 00:52:20 INFO - mozversion platform_changeset: f927dc3ad86478c7b54507fa8cf862cff4f372b4 00:52:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:52:20 INFO - mozversion platform_version: 52.0a1 00:52:20 INFO - using testdate: 1475567540 00:52:20 INFO - actual date: 1475567540 00:52:20 INFO - starting webserver on 'localhost:52770' 00:52:20 INFO - SUITE-START | Running 2 tests 00:52:20 INFO - TEST-START | dromaeo_css 00:52:20 INFO - operating with platform_type : linux_ 00:52:20 INFO - Initialising browser for dromaeo_css test... 00:52:20 INFO - TEST-INFO | started process 30882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8BZSx7/profile http://localhost:52770/getInfo.html) 00:52:25 INFO - PROCESS | 30882 | __metrics Screen width/height:1600/1200 00:52:25 INFO - PROCESS | 30882 | colorDepth:24 00:52:25 INFO - PROCESS | 30882 | Browser inner width/height: 1024/697 00:52:25 INFO - PROCESS | 30882 | __metrics 00:52:25 INFO - PROCESS | 30882 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:52:25 INFO - PROCESS | 30882 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:52:26 INFO - PROCESS | 30882 | console.error: PushService: 00:52:26 INFO - PROCESS | 30882 | stateChangeProcessEnqueue: Error transitioning state 00:52:26 INFO - PROCESS | 30882 | UnknownError 00:52:26 INFO - TEST-INFO | 30882: exit 0 00:52:26 INFO - Browser initialized. 00:52:26 INFO - Running cycle 1/1 for dromaeo_css test... 00:52:26 INFO - TEST-INFO | started process 30962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8BZSx7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:52:39 INFO - PROCESS | 30962 | RSS: Main: 175140864 00:52:39 INFO - PROCESS | 30962 | 00:53:31 INFO - PROCESS | 30962 | 1475567611001 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] 00:55:43 INFO - PROCESS | 30962 | Cycle 1(1): loaded http://localhost:52770/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52770/tests/dromaeo/cssquery-ext.html) 00:55:45 INFO - PROCESS | 30962 | RSS: Main: 289890304 00:55:45 INFO - PROCESS | 30962 | 00:58:47 INFO - PROCESS | 30962 | Cycle 1(1): loaded http://localhost:52770/tests/dromaeo/cssquery-ext.html (next: http://localhost:52770/tests/dromaeo/cssquery-jquery.html) 00:58:48 INFO - PROCESS | 30962 | RSS: Main: 272732160 00:58:48 INFO - PROCESS | 30962 | 01:01:50 INFO - PROCESS | 30962 | Cycle 1(1): loaded http://localhost:52770/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52770/tests/dromaeo/cssquery-mootools.html) 01:01:51 INFO - PROCESS | 30962 | RSS: Main: 243793920 01:01:51 INFO - PROCESS | 30962 | 01:04:53 INFO - PROCESS | 30962 | Cycle 1(1): loaded http://localhost:52770/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52770/tests/dromaeo/cssquery-prototype.html) 01:04:54 INFO - PROCESS | 30962 | RSS: Main: 219537408 01:04:54 INFO - PROCESS | 30962 | 01:07:57 INFO - PROCESS | 30962 | Cycle 1(1): loaded http://localhost:52770/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52770/tests/dromaeo/cssquery-yui.html) 01:07:57 INFO - PROCESS | 30962 | RSS: Main: 223178752 01:07:57 INFO - PROCESS | 30962 | 01:11:00 INFO - PROCESS | 30962 | Cycle 1(1): loaded http://localhost:52770/tests/dromaeo/cssquery-yui.html (next: http://localhost:52770/tests/dromaeo/cssquery-dojo.html) 01:11:01 INFO - PROCESS | 30962 | RSS: Main: 311664640 01:11:01 INFO - PROCESS | 30962 | 01:11:01 INFO - PROCESS | 30962 | __start_tp_report 01:11:01 INFO - PROCESS | 30962 | _x_x_mozilla_page_load 01:11:01 INFO - PROCESS | 30962 | _x_x_mozilla_page_load_details 01:11:01 INFO - PROCESS | 30962 | |i|pagename|runs| 01:11:01 INFO - PROCESS | 30962 | |0;dojo.html;2510.485350503147;2540.212534114426;2571.66568346115;2588.3658503666593;2591.4039770852705;4386.517483076859;4470.97764511177;4505.211587972104;4569.40597722296;4573.153966516193;4485.798139083741;4517.367568540407;4574.748388838612;4576.588107070363;4643.744594047326;4174.478190226222;4195.119025004753;4225.070484493406;4238.237117318881;4241.957580424202;4248.851290204843;4276.486821581415;4316.287812510932;4327.567243275663;4371.125774845028;4058.6753059755147;4261.339492378686;4281.571842815693;4283.850065247717;4374.015846434559;4095.058136628592;4148.688848336386;4148.875533733993;4174.3947127666315;4180.853670121531;4145.398917156996;4153.709240353177;4156.667466602665;4198.097409057067;4212.49450065991;4513.548645135493;4538.069695712404;4551.476580193287;4555.79498922546;4604.033153037866;4713.080949214905;4758.095961767253;4780.378550788375;4824.324594556765;4896.314515967767;4852.684575502581;4854.854354369375;4854.902901941941;4879.634027447955;4902.313676085351;4537.818487260539;4538.2738761797955;4540.477845047862;4586.449626044862;4599.05719327537;4815.735134567562;4864.464908860023;4941.777620007108;4942.604591632661;5020.3724534433195;4835.927461088087;4857.295692124693;4860.538248866352;4913.31213630092;4926.6551341406475;4933.432655244693;4941.604671626334;4947.925781113287;4950.578442787411;4996.4503904570465;4644.117617652635;4696.718196908197;4898.363212782316;4904.926426103611;4962.652614316963;4762.666613337033;4766.046790641885;4807.543283388072;4861.29511220871;4867;4045.7977101145416;4057.3711074783455;4087.6116768906904;4091.5294741105154;4105.34314509683;3611.1874828163454;3619.2761447710564;3621.492990981265;3632.854685812538;3704.073981504624;4124.360724087771;4222.641075508554;4224.957750422518;4225.049363893161;4337.436133302651;4863;4894.216925291937;4899.559039686445;4923.532264434873;4936.111499929975;4245.511766146871;4246.065865509583;4250.914981700349;4316;4318.719283246579;4242.618164365222;4299.269124248948;4362.912741745147;4363.258246098171;4367.192069467159;4592.058627981189;4628.560286772751;4673.6728429011;4684.48470668233;4753.524647535219;4964.851054468371;4965.081459929925;4965.726885021359;4975.776090076028;5014.52362025607;4685.906281874411;4688.718676879398;4691.7184968901975;4734.502877197845;4751.477337492942;4657.5575320344515;4681.508441613581;4795.808167673254;4884.804607815648;4886.853394398174;4889.119958407521;4907.656464047483;4919.0899683558655;4971.477994810492;4975.10448119342;4730.385049943486;4752.833650822205;4762.976185119052;4767.69010014348;4826.686265392738;4556.977215113903;4654.720716757005;4768.928466073081;4775.808967641395;4843.467218606021;4643.907121857476;4666.230072038075;4708.081924024782;4730.716157030589;4782.187028205144;4817.494163112823;4820.060088282751;4820.758962051813;4824.0834241494;4883.80464781419;4586.72479651222;4718.245080787057;4722.645801564965;4780.330753694555;4786.425628924551 01:11:01 INFO - PROCESS | 30962 | |1;ext.html;563.1215304125564;576.7318197038377;580.5935844908565;581.7527550790912;587.0050264801163;27912.72087279129;39531.604683953155;40280.99999999996;40489.59510404895;44298.778506107425;40051.59948400515;40357.394639080434;40385.7980710096;40421.393679094836;40450.7977460113;7692.653830577623;7829.295363417291;7856.057273127232;7862.606869656523;7879.921200787976;7694.884576731353;7783.027121609799;7785.493942893722;7785.766427007171;7792.259735325163;7755.302022817945;7792.9220707792765;7798.571078590675;7811.843763124734;7814.882776758353;7739.7678069658;7770.57261850598;7782.377409807202;7784.026996625422;7786.961065194638;7712.3444507216955;7772.06735191775;7772.145064043008;7774.144844067148;7780.883286750646;37703.62296377056;38061.619383806086;38092.61907380946;38100.23799524022;38113.80943095267;2767.6263704400053;2797.412543365875;2866.2117917572627;2867.2975121095255;3155.5169070536813;28599.57100643492;28604.856975715196;28617;29149.125526234246;29454.852725736233;3438.916726318313;3454.4127498325092;3537.0626783902285;3575.6603122703564;3579.928401431957;243502.99999999822;243851;244021;244575;244580;31350.52974205389;42731.78634106872;42842.35736463955;42924.57075429268;42933.14133717308;31982.68017319797;34088.318233635684;34114.317713645585;34124.82937585296;34125.82937085299;13308;13348.599542013755;13431.261280629658;13447.596572102853;13454.865451345557;11668.70828229284;11796.823047654292;11801.468933897824;11804.232724872856;11811.527538898348;7851.214878512217;7863.174366691529;7905.56519391439;7978.082520510099;7984.760457186294;3108.777224284647;3119.953200701991;3128.765342599314;3167.4773662345915;3177.4439473092116;851.4082712514867;864.3093692917772;877.7498412952278;890.3455959869491;931.7391130483476;26504.867475662497;27514.862425687745;27763.167104986882;27787.305317367227;27930.581041284397;760.8934749135126;896.5382827843666;904.0417157812608;962.5764663548016;978.9608415663436;13294.933525332312;14566.635834104232;14594.562163135122;14864.70270594582;14934.626634334229;353933;357535;357843;358397;359897;49383.50616493861;49972.75013624909;49991.50008499941;49994.500054998985;50009.749951250014;1045.592219034577;1089.6948854320804;1095.3646884806792;1133.7109037195628;1154.549725607014;24796.38009049716;29651.703482964895;29663.258418538844;29906.700932990392;30577.23556911006;46538.88072311975;51735;51751.22373164481;51752;51784.22323665072;338730;342967;343543;343696;344221;38781.224375512895;39232;39947.80026099851;41408;42119.789401054026;42586;43176.784116080475;43255.78372108119;43434.34848477212;43443;36295.27409451743;36324.81837590901;36327.27345453023;36455.635443646286;37084.25831483409;36184.276314473034;36207.27585448329;36297.27405451929;36728.26543469062;36815.81592092022;35188;35927.820360898026;36053.81973090118;36465.81767091148;36497;31460;33210.5018424719;33305.83347083249;33511;33624.663753362154;22856.428589285402;23013.309600712004;23040.4239894004;23278.418039549146;23351.299461016195 01:11:01 INFO - PROCESS | 30962 | |2;jquery.html;330.14327819308886;350.1508841060428;357.2105646521188;362.2718336144349;375.56246972277296;12025;13160.539381121662;15182.089074655514;16267.755983660254;16993.405230816923;16050.147964488526;16520.504384868444;16640.33438662452;16858.072805995664;16873.83126168741;4313.978430107845;4936.160852655039;5004.2677722229;5184.7148406837605;5186.818461353853;4994.875128121808;5122.948770512285;5123.820666276681;5129.281900533928;5129.615278854082;4802.735849528274;5079.060373830853;5093;5094.745262736848;5095.898082038357;5038.521340472649;5122.795088196468;5125.461826508219;5127.564157046656;5128.589712822965;4372.344148377737;4586.312053192048;4586.678932474728;4590.357349971006;4616.030633566955;19705.60588788216;19991.40025799228;20056.09747561363;20076.196952121896;20183.798162018487;1807.7378780076947;1879.830815226636;1999.6800511918168;2139.871607703543;2205.5368372641765;12782.61652150437;12826.102172847905;12826.486940522367;13197.208167509883;13657.931710341483;1597.177453611391;1670.6742185273877;1692.8307169283096;1763.215369160724;1770.5927636643644;64170;68727.31272687309;69340;70689.29310706879;73901.63049184774;9502.192313653279;9866.950665246628;9913.75215619601;9955.253355998184;10088.546015429323;13419.597412077654;13591.728165436834;13635.863641363658;13644.65888352799;13658.658533536742;5769.423057694281;5899.528037756969;5904.380040095814;6409.583377080568;7370.963145184347;6404.7117879695525;6593.604383736991;6604.603723776589;6639.634820084942;6718.563293386012;4130.752154870717;4186.434831297796;4254.404383386328;4320.135972805451;4332.176886391576;1757.428835628426;1776.4988584645953;1781.910904454772;1793.3543924187281;1837.1640903388925;827.3546633625782;870.1689886158704;887.4364778365784;897.2507955856802;912.2428384440898;16064.27710753019;16250.024998499892;16470;16825.242864071148;17577;855.1790281329869;859.4070091636751;865.5282870835409;867.8784970104191;885.4775682347446;8991.685291014914;9264.212541934012;9536.952315238519;9586.760330991781;9619;339939;342132;356717;357551;357969;73298;74137;74971.25028749752;76468.23531764722;76500;868.5037128533729;880.7886107334322;893.4282059481936;895.0154829687292;896.6816780043122;14366.784498232326;14487.710245795235;14620;14695.92652036733;15210.239488025332;35665.64334356623;36201;38101.809490952364;38922;39740.80129599449;46737.53262467332;49390;49736;49856.750716246184;49951;6823.215330237086;7094.503384763224;7111.217766045627;7296.124465064227;7429.44279179053;6080.787172448943;8207.71273005442;8408.075111737826;9423.340366174301;11270.83093753578;9357.57890894925;9717.514124293899;9804;10016.64941727036;10591.629292974709;10120.544575493974;10153.695389138338;10246.231532634933;10247.897521024992;10655;9398.765030874009;9685;9858.605655773688;10284.2801003929;10416.270861039655;6478.546501744832;6664.400203981665;6708.865822683617;7121.715131394893;7428.4800063995;7834.3340816028995;9631.181349585084;9838.65564705232;10215.438150901475;10436.321639093434 01:11:01 INFO - PROCESS | 30962 | |3;mootools.html;1211.2732360583657;1329.195836518906;1377.9655508612284;1427.5217802036325;1673.4979506148145;6191.566590338678;6948.756793512228;7233.927660723391;7253.202147763748;7451.25487451256;7255.818604534889;7344.96327518363;7349.742759003436;7350;7350.154732205798;2062.0926792211453;2077.169132347058;2079.5321052763156;2083.677030060343;2086.0091456558166;2039.7552293724773;2072.492239401349;2076.781937896514;2084.416363418238;2085.17635533964;2053.887036213008;2057.187410972665;2082.375287413777;2083.354160210332;2087.634663933813;1985.7617085949635;1990.572027014199;1993.0433391971935;1994.4714650617598;1998.5703073839195;1974.871633343828;1983.6429442700307;2023.0693880814695;2028.0366825757794;2030.5938812237464;7167.677454514559;7228.602426866521;7243.674034668453;7326.084239470067;7329.596872172028;4258.382534532507;4417;4417.646588272931;4424.159409712177;4425.889352766175;2620.358012286983;2743.6433263675794;2776.41695243999;2777.0558010276604;2801.3696918193446;815.5392203405057;821.8356328734277;829.203964194368;831.9708810191675;836.9288610468118;9379.484128372937;9489.288303377205;9489.952550237274;9501.382410143387;9516.714498564985;3538.7345949053924;3608.1520842602495;3611.6930060945115;3760.6615404613717;3786.280606684776;7553.962230188924;7611.4291428143115;7616.8476630467085;7621.199774023758;7624.046994125734;4225.7887105644595;4230.048239146167;4230.873073807791;4230.957690423118;4235.851745188904;3381.306832099414;3510.929781404409;3755;3920.921581568353;3946.0529472926864;3087.367089746597;3144.4497212987635;3241;3249.0505696582336;3284.425225585561;944.3012170993553;951.5480146930153;958.1807554540907;981.6809536900536;993.6174572789528;764.6673696941848;769.9499532530367;770.3644493293056;805.1063319715112;805.428146016335;4571.519990401027;4717.127331443694;4890;5014.824481143142;5016.147254966664;844.6719923501385;846.1749793950971;851.8381507513552;878.3851304087165;884.35883984111;3266.510023496447;3440.913977150591;3469.2887957968555;3573.3746594345885;3631.618680038558;8597;8634.352423568258;8754.824903501894;8761.605727742266;8766.079561645935;8733.694320698873;8734.737957861274;8748.168923952215;8752.431091979;8764.649414023495;6536.8365790855605;6577.651581425796;6619.404253617197;6645.66771661415;6691.397774200443;4809.975950120227;4989.950100498949;5064.392272927273;5104.310918026019;5139.974300128625;8000.679972801023;8030.718924837603;8036.919630803617;8112.918870811216;8130.065042520186;7999.160088190889;8114.472559283628;8269.95865020671;8316.501009939422;8323.6670533178;6167.259928808572;6338.397852204033;6340.461060809698;6348.460380867678;6349.396807303298;5899.91150132757;6098.115773212948;6509.1863517060365;6782.220044694726;6782.220044694924;6075.210222671025;6100.267967843887;6108.511319094373;6146.569740118328;6210.223722034746;6009.489193418608;6073.817785466443;6082.239720034996;6088.726007329769;6180.66006369636;5507.421720719267;5675.042110471881;5720.170575266647;5720.456556627114;5765.164051212467;4081.6530594898577;4110.979445102756;4147.854825081107;4195.433616461861;4215.704900656925;3997.9600203998752;4171.6036976487185;4205.306124489425;4250.277452833087;4252.893677658083 01:11:01 INFO - PROCESS | 30962 | |4;prototype.html;279.629490924525;279.86706314500617;285.78851649779165;295.0411163717917;297.4749567014222;4569;4677.906441871169;4758.381410416645;4764.976175119124;4773.976130119348;4489.147062058215;4565.178267911774;4582.427196600425;4621.399218101642;4622.58396744293;3464.1639930836695;3653.2145588698427;3672.485851980725;3678.282734866702;3683;3564.982175089121;3595.4247320428735;3607.683195633588;3618.9819050904707;3688.944665830015;3644.7995360255177;3652.5069115669444;3657.305112028706;3684.1894783147663;3699.833507492156;3659.432787917877;3662.9084272893256;3663.157473781045;3675.6691897729334;3681.9815900920325;3014.668386477486;3155.984220078908;3253.8047717137047;3259.1200375898375;3268.248302890325;4562.8631141065825;4571.634269258451;4572.359869618256;4576.7253964761885;4580.587747102743;4126.277901367249;4129.814158362881;4130.421740956269;4138.79306034697;4143.274926887812;4711;4871.269309603553;4875.512448755097;4876.829310974099;4885.316055752198;3466.722662187019;3484.372812893678;3492.9870337602065;3493.3013397320383;3496.5279687242405;5090.989059321547;5103.75434808683;5110.591152707774;5114.948850511484;5126.307948426989;3350.983245083759;3524.7356448266482;3562.2163124112653;3563;3564.180238545149;3583.6953858922284;3596.9640303597153;3607.1162565171703;3610.1335679436747;3618.5838628557526;4110.09577892869;4119.711620186618;4121.464209652726;4129.194807012664;4130.896727581834;4852.563269305709;4865.318855360252;4873.269009648581;4884.582131844689;4885.755712214446;1181.2144923625865;1225.9203151795284;1234.3087870792385;1245.63876475821;1250.7748605251143;770.5338270346472;790.8695065314158;802.9156938521371;809.1301850510724;809.3080416244144;3941.837158038328;3945.6129041929794;3947.210557888434;3969.903475289279;3979.2041591681777;4421.607193733964;4421.838385554344;4421.867343979686;4437.933430998538;4466.285394336891;3893.8637147699696;3929.901752456154;3942.7526310003595;3944.881653550398;3948.3287841067086;2363.279199844064;2370.3955491349598;2471.270975062361;2641.9735802642113;2666.600059946064;4748.4539277982785;4769.284607308931;4769.59458446029;4774.880627984258;4775.641826863;5145.794168233304;5151.4333423323405;5159.380874295033;5167.612429067835;5178.275041494194;4643.210654188796;4757.286407038971;4758.286257061538;4776.9761151194025;4785.59322457595;5003.124453220745;5012.644057293066;5039.445660977363;5046.697198168122;5048.772805223847;4953.2570114483115;4978.153713868724;4981.551660350586;4986.700797952134;4991.575716064175;4576.26779715244;4714.104320179155;4775.785089671042;4790.185668436444;4790.305405716222;3304.1078908695;3399.5070714746716;3530.646935306449;3553.307105114478;3565.0552603560595;4865;5014.674046186986;5029.270755740324;5046.823361182341;5050.77271522775;4889.731064791471;4893.926591101065;4894.975525122351;4899.579122054564;4908.631852610997;4674.205385084611;4897.926531101965;4899.951000489949;4900.803967841246;4915.778789954532;4806.831760888352;4816.736134017006;4832.420109586872;4832.613390928647;4832.9275060873415;4921.9015619688125;4929.137400954747;4934.50654934518;4948.505149485023;4986.276989836381;4636.304554316879;4717.504662010577;4835.830745923876;4850.902981940271;4868.659193856396 01:11:01 INFO - PROCESS | 30962 | |5;yui.html;589.3576002157648;594.2156353613229;604.9606775559588;635.7329921432997;718.4001358865347;12349.567765128222;13053.60839174824;13060.412281447334;13061.738765224689;13063.608091757262;12922;12925.74148517029;12981.935090324536;13066;13463.46146154155;739.2311995524648;770.2451597434517;772.3435080181829;773.0066864079658;773.6905237904826;762.3443838299058;764.675013119422;767.8387538616897;767.9270469305407;768.7424712721245;642.5020609027994;660.8248814064277;796.1004065406112;810.1614828652346;813;806.1736719862159;808.4664121679722;814.3241109878786;814.5153633588005;814.8329592433566;591.5918016568597;591.7100620695871;592.4223881715336;592.5052581094791;592.9762809487615;9800.264980126447;10249.84625230622;12288.631341059783;12389.876101238962;12437.253764774143;12503.874651281429;13523.323833808368;13832.723345533133;13847.238401887893;14075.155490670593;10017.198624110126;10223.539940702613;10363.689089327332;10538.789224215472;10735.731606709895;3224.742020638343;3275.737940964741;3290.276139249361;3292.0288514888166;3421.349943510725;62234;63003;63214.68392658053;63366.366336336505;63575.36424635787;10274.434906080089;10451.709508360369;10489.842652360221;10570.418626975435;10736.516856741466;19879.403617891487;20081.497962551053;20741.377758667266;20754.792452075588;20773.480662983548;6611.371919667624;6789.728410863609;6864.828379290458;6921.619310937846;6930.30696930313;3582.6417358264484;3603.3153700796765;3656.3418584654487;3692.8892133236045;3731.235096805203;2693.7440943110373;2800.453911487281;2801.579763035561;2802.523570992936;2806.059969910062;478.59080486183814;480.9302651115569;481.5882420530396;490.1324655359993;498.23272160872574;556.9303837020373;596.12962099646;596.492980966184;603.8007457539002;608.6196127420362;7584.900189472495;7940.920590794133;8168.264856162974;8295.751127466187;8605.526696031779;534.6337758635348;552.5082676417991;605.2948315212816;616.349751012677;626.3736263736264;3650.3976843821;3828.7511311764647;3833.271678381099;3864.768113913174;4022.4770779798437;90516;97404;97763.51118244506;101879;102130.48934755428;85220;88006.55996719975;88431.11568884358;88489.55755221183;88835;76105.61947190229;77088.61455692686;77519;78105;80286;7267.527610705287;7309.305615966475;7385.158834300289;7579;7619.390448763975;31447.685523145392;31813.5227971576;36923.815380922926;37955.62044379521;38241.80879095587;40770;42417.787911060244;58296.70851645715;59588.40411596002;59745.402545973986;10972.890271097187;11125.554977801121;11284.887151128383;11502.769944601228;12116.15186936906;12880.484780608671;13110.082294239312;13219.867801321863;13231.470741170631;13558.25429601342;11643.184977051525;12113.878861211275;12158.696032599255;12180.878191217975;12248.448819803309;11383.091897911003;11941.880581194077;12190.451429685509;12202.32887191213;12203.450844711831;10330.690079297634;10719.785604287714;10855.185861060294;11373;11380.772384552098;9818.852717209105;10077.19382449417;10199.592016319264;10241.129503992244;10513.894861051598;9683.564239609093;10298.176145908159;10448.68653940383;10477.842832357368;10511.316764410289 01:11:01 INFO - PROCESS | 30962 | __end_tp_report 01:11:01 INFO - PROCESS | 30962 | __start_cc_report 01:11:01 INFO - PROCESS | 30962 | _x_x_mozilla_cycle_collect,1095 01:11:01 INFO - PROCESS | 30962 | __end_cc_report 01:11:01 INFO - PROCESS | 30962 | __startTimestamp1475568661247__endTimestamp 01:11:01 INFO - PROCESS | 30962 | 01:11:01 INFO - PROCESS | 30962 | ------- Summary: start ------- 01:11:01 INFO - PROCESS | 30962 | Number of tests: 6 01:11:01 INFO - PROCESS | 30962 | 01:11:01 INFO - PROCESS | 30962 | [#0] dojo.html Cycles:165 Average:4519.44 Median:4657.56 stddev:473.12 (10.2%) stddev-sans-first:447.55 01:11:01 INFO - PROCESS | 30962 | Values: 2510.5 2540.2 2571.7 2588.4 2591.4 4386.5 4471.0 4505.2 4569.4 4573.2 4485.8 4517.4 4574.7 4576.6 4643.7 4174.5 4195.1 4225.1 4238.2 4242.0 4248.9 4276.5 4316.3 4327.6 4371.1 4058.7 4261.3 4281.6 4283.9 4374.0 4095.1 4148.7 4148.9 4174.4 4180.9 4145.4 4153.7 4156.7 4198.1 4212.5 4513.5 4538.1 4551.5 4555.8 4604.0 4713.1 4758.1 4780.4 4824.3 4896.3 4852.7 4854.9 4854.9 4879.6 4902.3 4537.8 4538.3 4540.5 4586.4 4599.1 4815.7 4864.5 4941.8 4942.6 5020.4 4835.9 4857.3 4860.5 4913.3 4926.7 4933.4 4941.6 4947.9 4950.6 4996.5 4644.1 4696.7 4898.4 4904.9 4962.7 4762.7 4766.0 4807.5 4861.3 4867.0 4045.8 4057.4 4087.6 4091.5 4105.3 3611.2 3619.3 3621.5 3632.9 3704.1 4124.4 4222.6 4225.0 4225.0 4337.4 4863.0 4894.2 4899.6 4923.5 4936.1 4245.5 4246.1 4250.9 4316.0 4318.7 4242.6 4299.3 4362.9 4363.3 4367.2 4592.1 4628.6 4673.7 4684.5 4753.5 4964.9 4965.1 4965.7 4975.8 5014.5 4685.9 4688.7 4691.7 4734.5 4751.5 4657.6 4681.5 4795.8 4884.8 4886.9 4889.1 4907.7 4919.1 4971.5 4975.1 4730.4 4752.8 4763.0 4767.7 4826.7 4557.0 4654.7 4768.9 4775.8 4843.5 4643.9 4666.2 4708.1 4730.7 4782.2 4817.5 4820.1 4820.8 4824.1 4883.8 4586.7 4718.2 4722.6 4780.3 4786.4 01:11:01 INFO - PROCESS | 30962 | 01:11:01 INFO - PROCESS | 30962 | [#1] ext.html Cycles:180 Average:46369.32 Median:36391.45 stddev:83947.90 (230.7%) stddev-sans-first:84112.94 01:11:01 INFO - PROCESS | 30962 | Values: 563.1 576.7 580.6 581.8 587.0 27912.7 39531.6 40281.0 40489.6 44298.8 40051.6 40357.4 40385.8 40421.4 40450.8 7692.7 7829.3 7856.1 7862.6 7879.9 7694.9 7783.0 7785.5 7785.8 7792.3 7755.3 7792.9 7798.6 7811.8 7814.9 7739.8 7770.6 7782.4 7784.0 7787.0 7712.3 7772.1 7772.1 7774.1 7780.9 37703.6 38061.6 38092.6 38100.2 38113.8 2767.6 2797.4 2866.2 2867.3 3155.5 28599.6 28604.9 28617.0 29149.1 29454.9 3438.9 3454.4 3537.1 3575.7 3579.9 243503.0 243851.0 244021.0 244575.0 244580.0 31350.5 42731.8 42842.4 42924.6 42933.1 31982.7 34088.3 34114.3 34124.8 34125.8 13308.0 13348.6 13431.3 13447.6 13454.9 11668.7 11796.8 11801.5 11804.2 11811.5 7851.2 7863.2 7905.6 7978.1 7984.8 3108.8 3120.0 3128.8 3167.5 3177.4 851.4 864.3 877.7 890.3 931.7 26504.9 27514.9 27763.2 27787.3 27930.6 760.9 896.5 904.0 962.6 979.0 13294.9 14566.6 14594.6 14864.7 14934.6 353933.0 357535.0 357843.0 358397.0 359897.0 49383.5 49972.8 49991.5 49994.5 50009.7 1045.6 1089.7 1095.4 1133.7 1154.5 24796.4 29651.7 29663.3 29906.7 30577.2 46538.9 51735.0 51751.2 51752.0 51784.2 338730.0 342967.0 343543.0 343696.0 344221.0 38781.2 39232.0 39947.8 41408.0 42119.8 42586.0 43176.8 43255.8 43434.3 43443.0 36295.3 36324.8 36327.3 36455.6 37084.3 36184.3 36207.3 36297.3 36728.3 36815.8 35188.0 35927.8 36053.8 36465.8 36497.0 31460.0 33210.5 33305.8 33511.0 33624.7 22856.4 23013.3 23040.4 23278.4 23351.3 01:11:01 INFO - PROCESS | 30962 | 01:11:01 INFO - PROCESS | 30962 | [#2] jquery.html Cycles:180 Average:22872.92 Median:4869.45 stddev:58226.46 (1195.8%) stddev-sans-first:58365.20 01:11:01 INFO - PROCESS | 30962 | Values: 330.1 350.2 357.2 362.3 375.6 12025.0 13160.5 15182.1 16267.8 16993.4 16050.1 16520.5 16640.3 16858.1 16873.8 4314.0 4936.2 5004.3 5184.7 5186.8 4994.9 5122.9 5123.8 5129.3 5129.6 4802.7 5079.1 5093.0 5094.7 5095.9 5038.5 5122.8 5125.5 5127.6 5128.6 4372.3 4586.3 4586.7 4590.4 4616.0 19705.6 19991.4 20056.1 20076.2 20183.8 1807.7 1879.8 1999.7 2139.9 2205.5 12782.6 12826.1 12826.5 13197.2 13657.9 1597.2 1670.7 1692.8 1763.2 1770.6 64170.0 68727.3 69340.0 70689.3 73901.6 9502.2 9867.0 9913.8 9955.3 10088.5 13419.6 13591.7 13635.9 13644.7 13658.7 5769.4 5899.5 5904.4 6409.6 7371.0 6404.7 6593.6 6604.6 6639.6 6718.6 4130.8 4186.4 4254.4 4320.1 4332.2 1757.4 1776.5 1781.9 1793.4 1837.2 827.4 870.2 887.4 897.3 912.2 16064.3 16250.0 16470.0 16825.2 17577.0 855.2 859.4 865.5 867.9 885.5 8991.7 9264.2 9537.0 9586.8 9619.0 339939.0 342132.0 356717.0 357551.0 357969.0 73298.0 74137.0 74971.3 76468.2 76500.0 868.5 880.8 893.4 895.0 896.7 14366.8 14487.7 14620.0 14695.9 15210.2 35665.6 36201.0 38101.8 38922.0 39740.8 46737.5 49390.0 49736.0 49856.8 49951.0 6823.2 7094.5 7111.2 7296.1 7429.4 6080.8 8207.7 8408.1 9423.3 11270.8 9357.6 9717.5 9804.0 10016.6 10591.6 10120.5 10153.7 10246.2 10247.9 10655.0 9398.8 9685.0 9858.6 10284.3 10416.3 6478.5 6664.4 6708.9 7121.7 7428.5 7834.3 9631.2 9838.7 10215.4 10436.3 01:11:01 INFO - PROCESS | 30962 | 01:11:01 INFO - PROCESS | 30962 | [#3] mootools.html Cycles:180 Average:4674.74 Median:5954.70 stddev:2570.29 (43.2%) stddev-sans-first:2564.32 01:11:01 INFO - PROCESS | 30962 | Values: 1211.3 1329.2 1378.0 1427.5 1673.5 6191.6 6948.8 7233.9 7253.2 7451.3 7255.8 7345.0 7349.7 7350.0 7350.2 2062.1 2077.2 2079.5 2083.7 2086.0 2039.8 2072.5 2076.8 2084.4 2085.2 2053.9 2057.2 2082.4 2083.4 2087.6 1985.8 1990.6 1993.0 1994.5 1998.6 1974.9 1983.6 2023.1 2028.0 2030.6 7167.7 7228.6 7243.7 7326.1 7329.6 4258.4 4417.0 4417.6 4424.2 4425.9 2620.4 2743.6 2776.4 2777.1 2801.4 815.5 821.8 829.2 832.0 836.9 9379.5 9489.3 9490.0 9501.4 9516.7 3538.7 3608.2 3611.7 3760.7 3786.3 7554.0 7611.4 7616.8 7621.2 7624.0 4225.8 4230.0 4230.9 4231.0 4235.9 3381.3 3510.9 3755.0 3920.9 3946.1 3087.4 3144.4 3241.0 3249.1 3284.4 944.3 951.5 958.2 981.7 993.6 764.7 769.9 770.4 805.1 805.4 4571.5 4717.1 4890.0 5014.8 5016.1 844.7 846.2 851.8 878.4 884.4 3266.5 3440.9 3469.3 3573.4 3631.6 8597.0 8634.4 8754.8 8761.6 8766.1 8733.7 8734.7 8748.2 8752.4 8764.6 6536.8 6577.7 6619.4 6645.7 6691.4 4810.0 4990.0 5064.4 5104.3 5140.0 8000.7 8030.7 8036.9 8112.9 8130.1 7999.2 8114.5 8270.0 8316.5 8323.7 6167.3 6338.4 6340.5 6348.5 6349.4 5899.9 6098.1 6509.2 6782.2 6782.2 6075.2 6100.3 6108.5 6146.6 6210.2 6009.5 6073.8 6082.2 6088.7 6180.7 5507.4 5675.0 5720.2 5720.5 5765.2 4081.7 4111.0 4147.9 4195.4 4215.7 3998.0 4171.6 4205.3 4250.3 4252.9 01:11:01 INFO - PROCESS | 30962 | 01:11:01 INFO - PROCESS | 30962 | [#4] prototype.html Cycles:180 Average:4017.75 Median:4574.31 stddev:1182.03 (25.8%) stddev-sans-first:1151.57 01:11:01 INFO - PROCESS | 30962 | Values: 279.6 279.9 285.8 295.0 297.5 4569.0 4677.9 4758.4 4765.0 4774.0 4489.1 4565.2 4582.4 4621.4 4622.6 3464.2 3653.2 3672.5 3678.3 3683.0 3565.0 3595.4 3607.7 3619.0 3688.9 3644.8 3652.5 3657.3 3684.2 3699.8 3659.4 3662.9 3663.2 3675.7 3682.0 3014.7 3156.0 3253.8 3259.1 3268.2 4562.9 4571.6 4572.4 4576.7 4580.6 4126.3 4129.8 4130.4 4138.8 4143.3 4711.0 4871.3 4875.5 4876.8 4885.3 3466.7 3484.4 3493.0 3493.3 3496.5 5091.0 5103.8 5110.6 5114.9 5126.3 3351.0 3524.7 3562.2 3563.0 3564.2 3583.7 3597.0 3607.1 3610.1 3618.6 4110.1 4119.7 4121.5 4129.2 4130.9 4852.6 4865.3 4873.3 4884.6 4885.8 1181.2 1225.9 1234.3 1245.6 1250.8 770.5 790.9 802.9 809.1 809.3 3941.8 3945.6 3947.2 3969.9 3979.2 4421.6 4421.8 4421.9 4437.9 4466.3 3893.9 3929.9 3942.8 3944.9 3948.3 2363.3 2370.4 2471.3 2642.0 2666.6 4748.5 4769.3 4769.6 4774.9 4775.6 5145.8 5151.4 5159.4 5167.6 5178.3 4643.2 4757.3 4758.3 4777.0 4785.6 5003.1 5012.6 5039.4 5046.7 5048.8 4953.3 4978.2 4981.6 4986.7 4991.6 4576.3 4714.1 4775.8 4790.2 4790.3 3304.1 3399.5 3530.6 3553.3 3565.1 4865.0 5014.7 5029.3 5046.8 5050.8 4889.7 4893.9 4895.0 4899.6 4908.6 4674.2 4897.9 4900.0 4900.8 4915.8 4806.8 4816.7 4832.4 4832.6 4832.9 4921.9 4929.1 4934.5 4948.5 4986.3 4636.3 4717.5 4835.8 4850.9 4868.7 01:11:01 INFO - PROCESS | 30962 | 01:11:01 INFO - PROCESS | 30962 | [#5] yui.html Cycles:180 Average:17454.00 Median:3831.01 stddev:25275.60 (659.8%) stddev-sans-first:25314.78 01:11:01 INFO - PROCESS | 30962 | Values: 589.4 594.2 605.0 635.7 718.4 12349.6 13053.6 13060.4 13061.7 13063.6 12922.0 12925.7 12981.9 13066.0 13463.5 739.2 770.2 772.3 773.0 773.7 762.3 764.7 767.8 767.9 768.7 642.5 660.8 796.1 810.2 813.0 806.2 808.5 814.3 814.5 814.8 591.6 591.7 592.4 592.5 593.0 9800.3 10249.8 12288.6 12389.9 12437.3 12503.9 13523.3 13832.7 13847.2 14075.2 10017.2 10223.5 10363.7 10538.8 10735.7 3224.7 3275.7 3290.3 3292.0 3421.3 62234.0 63003.0 63214.7 63366.4 63575.4 10274.4 10451.7 10489.8 10570.4 10736.5 19879.4 20081.5 20741.4 20754.8 20773.5 6611.4 6789.7 6864.8 6921.6 6930.3 3582.6 3603.3 3656.3 3692.9 3731.2 2693.7 2800.5 2801.6 2802.5 2806.1 478.6 480.9 481.6 490.1 498.2 556.9 596.1 596.5 603.8 608.6 7584.9 7940.9 8168.3 8295.8 8605.5 534.6 552.5 605.3 616.3 626.4 3650.4 3828.8 3833.3 3864.8 4022.5 90516.0 97404.0 97763.5 101879.0 102130.5 85220.0 88006.6 88431.1 88489.6 88835.0 76105.6 77088.6 77519.0 78105.0 80286.0 7267.5 7309.3 7385.2 7579.0 7619.4 31447.7 31813.5 36923.8 37955.6 38241.8 40770.0 42417.8 58296.7 59588.4 59745.4 10972.9 11125.6 11284.9 11502.8 12116.2 12880.5 13110.1 13219.9 13231.5 13558.3 11643.2 12113.9 12158.7 12180.9 12248.4 11383.1 11941.9 12190.5 12202.3 12203.5 10330.7 10719.8 10855.2 11373.0 11380.8 9818.9 10077.2 10199.6 10241.1 10513.9 9683.6 10298.2 10448.7 10477.8 10511.3 01:11:01 INFO - PROCESS | 30962 | -------- Summary: end -------- 01:11:01 INFO - PROCESS | 30962 | 01:11:02 INFO - TEST-INFO | 30962: exit 0 01:11:02 INFO - TEST-OK | dromaeo_css | took 1121562ms 01:11:02 INFO - TEST-START | kraken 01:11:02 INFO - operating with platform_type : linux_ 01:11:02 INFO - Initialising browser for kraken test... 01:11:02 INFO - TEST-INFO | started process 31264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmrpCN2/profile http://localhost:52770/getInfo.html) 01:11:06 INFO - PROCESS | 31264 | __metrics Screen width/height:1600/1200 01:11:06 INFO - PROCESS | 31264 | colorDepth:24 01:11:06 INFO - PROCESS | 31264 | Browser inner width/height: 1024/697 01:11:06 INFO - PROCESS | 31264 | __metrics 01:11:07 INFO - PROCESS | 31264 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:11:07 INFO - PROCESS | 31264 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:11:07 INFO - PROCESS | 31264 | console.error: PushService: 01:11:07 INFO - PROCESS | 31264 | stateChangeProcessEnqueue: Error transitioning state 01:11:07 INFO - PROCESS | 31264 | UnknownError 01:11:08 INFO - TEST-INFO | 31264: exit 0 01:11:08 INFO - Browser initialized. 01:11:08 INFO - Running cycle 1/1 for kraken test... 01:11:08 INFO - TEST-INFO | started process 31347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmrpCN2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:11:20 INFO - PROCESS | 31347 | RSS: Main: 175034368 01:11:20 INFO - PROCESS | 31347 | 01:11:23 INFO - PROCESS | 31347 | Cycle 1(1): loaded http://localhost:52770/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52770/tests/kraken/driver.html?testName=audio-beat-detection) 01:11:24 INFO - PROCESS | 31347 | RSS: Main: 241860608 01:11:24 INFO - PROCESS | 31347 | 01:11:27 INFO - PROCESS | 31347 | Cycle 1(1): loaded http://localhost:52770/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52770/tests/kraken/driver.html?testName=audio-dft) 01:11:27 INFO - PROCESS | 31347 | RSS: Main: 218607616 01:11:27 INFO - PROCESS | 31347 | 01:11:30 INFO - PROCESS | 31347 | Cycle 1(1): loaded http://localhost:52770/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52770/tests/kraken/driver.html?testName=audio-fft) 01:11:31 INFO - PROCESS | 31347 | RSS: Main: 300417024 01:11:31 INFO - PROCESS | 31347 | 01:11:33 INFO - PROCESS | 31347 | Cycle 1(1): loaded http://localhost:52770/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52770/tests/kraken/driver.html?testName=audio-oscillator) 01:11:34 INFO - PROCESS | 31347 | RSS: Main: 208658432 01:11:34 INFO - PROCESS | 31347 | 01:11:36 INFO - PROCESS | 31347 | Cycle 1(1): loaded http://localhost:52770/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52770/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:11:37 INFO - PROCESS | 31347 | RSS: Main: 213884928 01:11:37 INFO - PROCESS | 31347 | 01:11:40 INFO - PROCESS | 31347 | Cycle 1(1): loaded http://localhost:52770/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52770/tests/kraken/driver.html?testName=imaging-darkroom) 01:11:41 INFO - PROCESS | 31347 | RSS: Main: 250167296 01:11:41 INFO - PROCESS | 31347 | 01:11:44 INFO - PROCESS | 31347 | Cycle 1(1): loaded http://localhost:52770/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52770/tests/kraken/driver.html?testName=imaging-desaturate) 01:11:45 INFO - PROCESS | 31347 | RSS: Main: 244518912 01:11:45 INFO - PROCESS | 31347 | 01:11:48 INFO - PROCESS | 31347 | Cycle 1(1): loaded http://localhost:52770/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52770/tests/kraken/driver.html?testName=json-parse-financial) 01:11:48 INFO - PROCESS | 31347 | RSS: Main: 247926784 01:11:48 INFO - PROCESS | 31347 | 01:11:50 INFO - PROCESS | 31347 | Cycle 1(1): loaded http://localhost:52770/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52770/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:11:50 INFO - PROCESS | 31347 | RSS: Main: 211165184 01:11:50 INFO - PROCESS | 31347 | 01:11:52 INFO - PROCESS | 31347 | Cycle 1(1): loaded http://localhost:52770/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52770/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:11:53 INFO - PROCESS | 31347 | RSS: Main: 218554368 01:11:53 INFO - PROCESS | 31347 | 01:11:55 INFO - PROCESS | 31347 | Cycle 1(1): loaded http://localhost:52770/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52770/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:11:56 INFO - PROCESS | 31347 | RSS: Main: 227536896 01:11:56 INFO - PROCESS | 31347 | 01:11:59 INFO - PROCESS | 31347 | Cycle 1(1): loaded http://localhost:52770/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:11:59 INFO - PROCESS | 31347 | RSS: Main: 236199936 01:11:59 INFO - PROCESS | 31347 | 01:12:02 INFO - PROCESS | 31347 | Cycle 1(1): loaded http://localhost:52770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:12:03 INFO - PROCESS | 31347 | RSS: Main: 232722432 01:12:03 INFO - PROCESS | 31347 | 01:12:05 INFO - PROCESS | 31347 | Cycle 1(1): loaded http://localhost:52770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52770/tests/kraken/driver.html?testName=ai-astar) 01:12:05 INFO - PROCESS | 31347 | RSS: Main: 283721728 01:12:05 INFO - PROCESS | 31347 | 01:12:05 INFO - PROCESS | 31347 | __start_tp_report 01:12:05 INFO - PROCESS | 31347 | _x_x_mozilla_page_load 01:12:05 INFO - PROCESS | 31347 | _x_x_mozilla_page_load_details 01:12:05 INFO - PROCESS | 31347 | |i|pagename|runs| 01:12:05 INFO - PROCESS | 31347 | |0;ai-astar;112;117;118;114;115;116;115;116;118;116 01:12:05 INFO - PROCESS | 31347 | |1;audio-beat-detection;152;141;126;177;126;129;130;131;168;131 01:12:05 INFO - PROCESS | 31347 | |2;audio-dft;160;161;162;162;162;163;162;162;162;161 01:12:05 INFO - PROCESS | 31347 | |3;audio-fft;75;77;75;112;77;77;78;77;102;75 01:12:05 INFO - PROCESS | 31347 | |4;audio-oscillator;84;82;113;83;83;84;103;83;83;111 01:12:05 INFO - PROCESS | 31347 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;116;118;117 01:12:05 INFO - PROCESS | 31347 | |6;imaging-darkroom;148;148;147;147;148;148;147;147;148;147 01:12:05 INFO - PROCESS | 31347 | |7;imaging-desaturate;95;94;95;95;94;95;95;95;95;95 01:12:05 INFO - PROCESS | 31347 | |8;json-parse-financial;65;65;63;65;64;64;64;74;64;64 01:12:05 INFO - PROCESS | 31347 | |9;json-stringify-tinderbox;66;66;67;66;66;66;67;67;66;66 01:12:05 INFO - PROCESS | 31347 | |10;stanford-crypto-aes;83;83;83;83;85;83;84;83;83;89 01:12:05 INFO - PROCESS | 31347 | |11;stanford-crypto-ccm;140;140;139;139;148;149;138;137;184;138 01:12:05 INFO - PROCESS | 31347 | |12;stanford-crypto-pbkdf2;175;175;174;178;180;174;175;174;175;175 01:12:05 INFO - PROCESS | 31347 | |13;stanford-crypto-sha256-iterative;70;71;69;70;72;73;73;71;69;70 01:12:05 INFO - PROCESS | 31347 | __end_tp_report 01:12:05 INFO - PROCESS | 31347 | __start_cc_report 01:12:05 INFO - PROCESS | 31347 | _x_x_mozilla_cycle_collect,1889 01:12:05 INFO - PROCESS | 31347 | __end_cc_report 01:12:05 INFO - PROCESS | 31347 | __startTimestamp1475568725503__endTimestamp 01:12:05 INFO - PROCESS | 31347 | 01:12:05 INFO - PROCESS | 31347 | ------- Summary: start ------- 01:12:05 INFO - PROCESS | 31347 | Number of tests: 14 01:12:05 INFO - PROCESS | 31347 | 01:12:05 INFO - PROCESS | 31347 | [#0] ai-astar Cycles:10 Average:115.70 Median:116.00 stddev:1.83 (1.6%) stddev-sans-first:1.36 01:12:05 INFO - PROCESS | 31347 | Values: 112.0 117.0 118.0 114.0 115.0 116.0 115.0 116.0 118.0 116.0 01:12:05 INFO - PROCESS | 31347 | 01:12:05 INFO - PROCESS | 31347 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:136.00 stddev:18.44 (13.6%) stddev-sans-first:19.13 01:12:05 INFO - PROCESS | 31347 | Values: 152.0 141.0 126.0 177.0 126.0 129.0 130.0 131.0 168.0 131.0 01:12:05 INFO - PROCESS | 31347 | 01:12:05 INFO - PROCESS | 31347 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.60 01:12:05 INFO - PROCESS | 31347 | Values: 160.0 161.0 162.0 162.0 162.0 163.0 162.0 162.0 162.0 161.0 01:12:05 INFO - PROCESS | 31347 | 01:12:05 INFO - PROCESS | 31347 | [#3] audio-fft Cycles:10 Average:82.50 Median:77.00 stddev:13.17 (17.1%) stddev-sans-first:13.68 01:12:05 INFO - PROCESS | 31347 | Values: 75.0 77.0 75.0 112.0 77.0 77.0 78.0 77.0 102.0 75.0 01:12:05 INFO - PROCESS | 31347 | 01:12:05 INFO - PROCESS | 31347 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:83.00 stddev:12.75 (15.4%) stddev-sans-first:13.28 01:12:05 INFO - PROCESS | 31347 | Values: 84.0 82.0 113.0 83.0 83.0 84.0 103.0 83.0 83.0 111.0 01:12:05 INFO - PROCESS | 31347 | 01:12:05 INFO - PROCESS | 31347 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 01:12:05 INFO - PROCESS | 31347 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 118.0 117.0 01:12:05 INFO - PROCESS | 31347 | 01:12:05 INFO - PROCESS | 31347 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 01:12:05 INFO - PROCESS | 31347 | Values: 148.0 148.0 147.0 147.0 148.0 148.0 147.0 147.0 148.0 147.0 01:12:05 INFO - PROCESS | 31347 | 01:12:05 INFO - PROCESS | 31347 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:12:05 INFO - PROCESS | 31347 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 01:12:05 INFO - PROCESS | 31347 | 01:12:05 INFO - PROCESS | 31347 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:64.50 stddev:3.16 (4.9%) stddev-sans-first:3.35 01:12:05 INFO - PROCESS | 31347 | Values: 65.0 65.0 63.0 65.0 64.0 64.0 64.0 74.0 64.0 64.0 01:12:05 INFO - PROCESS | 31347 | 01:12:05 INFO - PROCESS | 31347 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 01:12:05 INFO - PROCESS | 31347 | Values: 66.0 66.0 67.0 66.0 66.0 66.0 67.0 67.0 66.0 66.0 01:12:05 INFO - PROCESS | 31347 | 01:12:05 INFO - PROCESS | 31347 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.00 stddev:1.91 (2.3%) stddev-sans-first:2.00 01:12:05 INFO - PROCESS | 31347 | Values: 83.0 83.0 83.0 83.0 85.0 83.0 84.0 83.0 83.0 89.0 01:12:05 INFO - PROCESS | 31347 | 01:12:05 INFO - PROCESS | 31347 | [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:140.00 stddev:14.26 (10.2%) stddev-sans-first:15.00 01:12:05 INFO - PROCESS | 31347 | Values: 140.0 140.0 139.0 139.0 148.0 149.0 138.0 137.0 184.0 138.0 01:12:05 INFO - PROCESS | 31347 | 01:12:05 INFO - PROCESS | 31347 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:175.00 stddev:1.96 (1.1%) stddev-sans-first:2.07 01:12:05 INFO - PROCESS | 31347 | Values: 175.0 175.0 174.0 178.0 180.0 174.0 175.0 174.0 175.0 175.0 01:12:05 INFO - PROCESS | 31347 | 01:12:05 INFO - PROCESS | 31347 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.48 (2.1%) stddev-sans-first:1.54 01:12:05 INFO - PROCESS | 31347 | Values: 70.0 71.0 69.0 70.0 72.0 73.0 73.0 71.0 69.0 70.0 01:12:05 INFO - PROCESS | 31347 | -------- Summary: end -------- 01:12:05 INFO - PROCESS | 31347 | 01:12:06 INFO - TEST-INFO | 31347: exit 0 01:12:06 INFO - TEST-OK | kraken | took 64701ms 01:12:06 INFO - SUITE-END | took 1186s 01:12:07 INFO - Completed test suite (00:19:46) 01:12:07 INFO - javascript benchmark 01:12:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2510.485350503147, 2540.212534114426, 2571.66568346115, 2588.3658503666593, 2591.4039770852705, 4386.517483076859, 4470.97764511177, 4505.211587972104, 4569.40597722296, 4573.153966516193, 4485.798139083741, 4517.367568540407, 4574.748388838612, 4576.588107070363, 4643.744594047326, 4174.478190226222, 4195.119025004753, 4225.070484493406, 4238.237117318881, 4241.957580424202, 4248.851290204843, 4276.486821581415, 4316.287812510932, 4327.567243275663, 4371.125774845028, 4058.6753059755147, 4261.339492378686, 4281.571842815693, 4283.850065247717, 4374.015846434559, 4095.058136628592, 4148.688848336386, 4148.875533733993, 4174.3947127666315, 4180.853670121531, 4145.398917156996, 4153.709240353177, 4156.667466602665, 4198.097409057067, 4212.49450065991, 4513.548645135493, 4538.069695712404, 4551.476580193287, 4555.79498922546, 4604.033153037866, 4713.080949214905, 4758.095961767253, 4780.378550788375, 4824.324594556765, 4896.314515967767, 4852.684575502581, 4854.854354369375, 4854.902901941941, 4879.634027447955, 4902.313676085351, 4537.818487260539, 4538.2738761797955, 4540.477845047862, 4586.449626044862, 4599.05719327537, 4815.735134567562, 4864.464908860023, 4941.777620007108, 4942.604591632661, 5020.3724534433195, 4835.927461088087, 4857.295692124693, 4860.538248866352, 4913.31213630092, 4926.6551341406475, 4933.432655244693, 4941.604671626334, 4947.925781113287, 4950.578442787411, 4996.4503904570465, 4644.117617652635, 4696.718196908197, 4898.363212782316, 4904.926426103611, 4962.652614316963, 4762.666613337033, 4766.046790641885, 4807.543283388072, 4861.29511220871, 4867.0, 4045.7977101145416, 4057.3711074783455, 4087.6116768906904, 4091.5294741105154, 4105.34314509683, 3611.1874828163454, 3619.2761447710564, 3621.492990981265, 3632.854685812538, 3704.073981504624, 4124.360724087771, 4222.641075508554, 4224.957750422518, 4225.049363893161, 4337.436133302651, 4863.0, 4894.216925291937, 4899.559039686445, 4923.532264434873, 4936.111499929975, 4245.511766146871, 4246.065865509583, 4250.914981700349, 4316.0, 4318.719283246579, 4242.618164365222, 4299.269124248948, 4362.912741745147, 4363.258246098171, 4367.192069467159, 4592.058627981189, 4628.560286772751, 4673.6728429011, 4684.48470668233, 4753.524647535219, 4964.851054468371, 4965.081459929925, 4965.726885021359, 4975.776090076028, 5014.52362025607, 4685.906281874411, 4688.718676879398, 4691.7184968901975, 4734.502877197845, 4751.477337492942, 4657.5575320344515, 4681.508441613581, 4795.808167673254, 4884.804607815648, 4886.853394398174, 4889.119958407521, 4907.656464047483, 4919.0899683558655, 4971.477994810492, 4975.10448119342, 4730.385049943486, 4752.833650822205, 4762.976185119052, 4767.69010014348, 4826.686265392738, 4556.977215113903, 4654.720716757005, 4768.928466073081, 4775.808967641395, 4843.467218606021, 4643.907121857476, 4666.230072038075, 4708.081924024782, 4730.716157030589, 4782.187028205144, 4817.494163112823, 4820.060088282751, 4820.758962051813, 4824.0834241494, 4883.80464781419, 4586.72479651222, 4718.245080787057, 4722.645801564965, 4780.330753694555, 4786.425628924551], "value": 4489.424753472471, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.1215304125564, 576.7318197038377, 580.5935844908565, 581.7527550790912, 587.0050264801163, 27912.72087279129, 39531.604683953155, 40280.99999999996, 40489.59510404895, 44298.778506107425, 40051.59948400515, 40357.394639080434, 40385.7980710096, 40421.393679094836, 40450.7977460113, 7692.653830577623, 7829.295363417291, 7856.057273127232, 7862.606869656523, 7879.921200787976, 7694.884576731353, 7783.027121609799, 7785.493942893722, 7785.766427007171, 7792.259735325163, 7755.302022817945, 7792.9220707792765, 7798.571078590675, 7811.843763124734, 7814.882776758353, 7739.7678069658, 7770.57261850598, 7782.377409807202, 7784.026996625422, 7786.961065194638, 7712.3444507216955, 7772.06735191775, 7772.145064043008, 7774.144844067148, 7780.883286750646, 37703.62296377056, 38061.619383806086, 38092.61907380946, 38100.23799524022, 38113.80943095267, 2767.6263704400053, 2797.412543365875, 2866.2117917572627, 2867.2975121095255, 3155.5169070536813, 28599.57100643492, 28604.856975715196, 28617.0, 29149.125526234246, 29454.852725736233, 3438.916726318313, 3454.4127498325092, 3537.0626783902285, 3575.6603122703564, 3579.928401431957, 243502.99999999822, 243851.0, 244021.0, 244575.0, 244580.0, 31350.52974205389, 42731.78634106872, 42842.35736463955, 42924.57075429268, 42933.14133717308, 31982.68017319797, 34088.318233635684, 34114.317713645585, 34124.82937585296, 34125.82937085299, 13308.0, 13348.599542013755, 13431.261280629658, 13447.596572102853, 13454.865451345557, 11668.70828229284, 11796.823047654292, 11801.468933897824, 11804.232724872856, 11811.527538898348, 7851.214878512217, 7863.174366691529, 7905.56519391439, 7978.082520510099, 7984.760457186294, 3108.777224284647, 3119.953200701991, 3128.765342599314, 3167.4773662345915, 3177.4439473092116, 851.4082712514867, 864.3093692917772, 877.7498412952278, 890.3455959869491, 931.7391130483476, 26504.867475662497, 27514.862425687745, 27763.167104986882, 27787.305317367227, 27930.581041284397, 760.8934749135126, 896.5382827843666, 904.0417157812608, 962.5764663548016, 978.9608415663436, 13294.933525332312, 14566.635834104232, 14594.562163135122, 14864.70270594582, 14934.626634334229, 353933.0, 357535.0, 357843.0, 358397.0, 359897.0, 49383.50616493861, 49972.75013624909, 49991.50008499941, 49994.500054998985, 50009.749951250014, 1045.592219034577, 1089.6948854320804, 1095.3646884806792, 1133.7109037195628, 1154.549725607014, 24796.38009049716, 29651.703482964895, 29663.258418538844, 29906.700932990392, 30577.23556911006, 46538.88072311975, 51735.0, 51751.22373164481, 51752.0, 51784.22323665072, 338730.0, 342967.0, 343543.0, 343696.0, 344221.0, 38781.224375512895, 39232.0, 39947.80026099851, 41408.0, 42119.789401054026, 42586.0, 43176.784116080475, 43255.78372108119, 43434.34848477212, 43443.0, 36295.27409451743, 36324.81837590901, 36327.27345453023, 36455.635443646286, 37084.25831483409, 36184.276314473034, 36207.27585448329, 36297.27405451929, 36728.26543469062, 36815.81592092022, 35188.0, 35927.820360898026, 36053.81973090118, 36465.81767091148, 36497.0, 31460.0, 33210.5018424719, 33305.83347083249, 33511.0, 33624.663753362154, 22856.428589285402, 23013.309600712004, 23040.4239894004, 23278.418039549146, 23351.299461016195], "value": 16547.598526693568, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.14327819308886, 350.1508841060428, 357.2105646521188, 362.2718336144349, 375.56246972277296, 12025.0, 13160.539381121662, 15182.089074655514, 16267.755983660254, 16993.405230816923, 16050.147964488526, 16520.504384868444, 16640.33438662452, 16858.072805995664, 16873.83126168741, 4313.978430107845, 4936.160852655039, 5004.2677722229, 5184.7148406837605, 5186.818461353853, 4994.875128121808, 5122.948770512285, 5123.820666276681, 5129.281900533928, 5129.615278854082, 4802.735849528274, 5079.060373830853, 5093.0, 5094.745262736848, 5095.898082038357, 5038.521340472649, 5122.795088196468, 5125.461826508219, 5127.564157046656, 5128.589712822965, 4372.344148377737, 4586.312053192048, 4586.678932474728, 4590.357349971006, 4616.030633566955, 19705.60588788216, 19991.40025799228, 20056.09747561363, 20076.196952121896, 20183.798162018487, 1807.7378780076947, 1879.830815226636, 1999.6800511918168, 2139.871607703543, 2205.5368372641765, 12782.61652150437, 12826.102172847905, 12826.486940522367, 13197.208167509883, 13657.931710341483, 1597.177453611391, 1670.6742185273877, 1692.8307169283096, 1763.215369160724, 1770.5927636643644, 64170.0, 68727.31272687309, 69340.0, 70689.29310706879, 73901.63049184774, 9502.192313653279, 9866.950665246628, 9913.75215619601, 9955.253355998184, 10088.546015429323, 13419.597412077654, 13591.728165436834, 13635.863641363658, 13644.65888352799, 13658.658533536742, 5769.423057694281, 5899.528037756969, 5904.380040095814, 6409.583377080568, 7370.963145184347, 6404.7117879695525, 6593.604383736991, 6604.603723776589, 6639.634820084942, 6718.563293386012, 4130.752154870717, 4186.434831297796, 4254.404383386328, 4320.135972805451, 4332.176886391576, 1757.428835628426, 1776.4988584645953, 1781.910904454772, 1793.3543924187281, 1837.1640903388925, 827.3546633625782, 870.1689886158704, 887.4364778365784, 897.2507955856802, 912.2428384440898, 16064.27710753019, 16250.024998499892, 16470.0, 16825.242864071148, 17577.0, 855.1790281329869, 859.4070091636751, 865.5282870835409, 867.8784970104191, 885.4775682347446, 8991.685291014914, 9264.212541934012, 9536.952315238519, 9586.760330991781, 9619.0, 339939.0, 342132.0, 356717.0, 357551.0, 357969.0, 73298.0, 74137.0, 74971.25028749752, 76468.23531764722, 76500.0, 868.5037128533729, 880.7886107334322, 893.4282059481936, 895.0154829687292, 896.6816780043122, 14366.784498232326, 14487.710245795235, 14620.0, 14695.92652036733, 15210.239488025332, 35665.64334356623, 36201.0, 38101.809490952364, 38922.0, 39740.80129599449, 46737.53262467332, 49390.0, 49736.0, 49856.750716246184, 49951.0, 6823.215330237086, 7094.503384763224, 7111.217766045627, 7296.124465064227, 7429.44279179053, 6080.787172448943, 8207.71273005442, 8408.075111737826, 9423.340366174301, 11270.83093753578, 9357.57890894925, 9717.514124293899, 9804.0, 10016.64941727036, 10591.629292974709, 10120.544575493974, 10153.695389138338, 10246.231532634933, 10247.897521024992, 10655.0, 9398.765030874009, 9685.0, 9858.605655773688, 10284.2801003929, 10416.270861039655, 6478.546501744832, 6664.400203981665, 6708.865822683617, 7121.715131394893, 7428.4800063995, 7834.3340816028995, 9631.181349585084, 9838.65564705232, 10215.438150901475, 10436.321639093434], "value": 7902.804796473902, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1211.2732360583657, 1329.195836518906, 1377.9655508612284, 1427.5217802036325, 1673.4979506148145, 6191.566590338678, 6948.756793512228, 7233.927660723391, 7253.202147763748, 7451.25487451256, 7255.818604534889, 7344.96327518363, 7349.742759003436, 7350.0, 7350.154732205798, 2062.0926792211453, 2077.169132347058, 2079.5321052763156, 2083.677030060343, 2086.0091456558166, 2039.7552293724773, 2072.492239401349, 2076.781937896514, 2084.416363418238, 2085.17635533964, 2053.887036213008, 2057.187410972665, 2082.375287413777, 2083.354160210332, 2087.634663933813, 1985.7617085949635, 1990.572027014199, 1993.0433391971935, 1994.4714650617598, 1998.5703073839195, 1974.871633343828, 1983.6429442700307, 2023.0693880814695, 2028.0366825757794, 2030.5938812237464, 7167.677454514559, 7228.602426866521, 7243.674034668453, 7326.084239470067, 7329.596872172028, 4258.382534532507, 4417.0, 4417.646588272931, 4424.159409712177, 4425.889352766175, 2620.358012286983, 2743.6433263675794, 2776.41695243999, 2777.0558010276604, 2801.3696918193446, 815.5392203405057, 821.8356328734277, 829.203964194368, 831.9708810191675, 836.9288610468118, 9379.484128372937, 9489.288303377205, 9489.952550237274, 9501.382410143387, 9516.714498564985, 3538.7345949053924, 3608.1520842602495, 3611.6930060945115, 3760.6615404613717, 3786.280606684776, 7553.962230188924, 7611.4291428143115, 7616.8476630467085, 7621.199774023758, 7624.046994125734, 4225.7887105644595, 4230.048239146167, 4230.873073807791, 4230.957690423118, 4235.851745188904, 3381.306832099414, 3510.929781404409, 3755.0, 3920.921581568353, 3946.0529472926864, 3087.367089746597, 3144.4497212987635, 3241.0, 3249.0505696582336, 3284.425225585561, 944.3012170993553, 951.5480146930153, 958.1807554540907, 981.6809536900536, 993.6174572789528, 764.6673696941848, 769.9499532530367, 770.3644493293056, 805.1063319715112, 805.428146016335, 4571.519990401027, 4717.127331443694, 4890.0, 5014.824481143142, 5016.147254966664, 844.6719923501385, 846.1749793950971, 851.8381507513552, 878.3851304087165, 884.35883984111, 3266.510023496447, 3440.913977150591, 3469.2887957968555, 3573.3746594345885, 3631.618680038558, 8597.0, 8634.352423568258, 8754.824903501894, 8761.605727742266, 8766.079561645935, 8733.694320698873, 8734.737957861274, 8748.168923952215, 8752.431091979, 8764.649414023495, 6536.8365790855605, 6577.651581425796, 6619.404253617197, 6645.66771661415, 6691.397774200443, 4809.975950120227, 4989.950100498949, 5064.392272927273, 5104.310918026019, 5139.974300128625, 8000.679972801023, 8030.718924837603, 8036.919630803617, 8112.918870811216, 8130.065042520186, 7999.160088190889, 8114.472559283628, 8269.95865020671, 8316.501009939422, 8323.6670533178, 6167.259928808572, 6338.397852204033, 6340.461060809698, 6348.460380867678, 6349.396807303298, 5899.91150132757, 6098.115773212948, 6509.1863517060365, 6782.220044694726, 6782.220044694924, 6075.210222671025, 6100.267967843887, 6108.511319094373, 6146.569740118328, 6210.223722034746, 6009.489193418608, 6073.817785466443, 6082.239720034996, 6088.726007329769, 6180.66006369636, 5507.421720719267, 5675.042110471881, 5720.170575266647, 5720.456556627114, 5765.164051212467, 4081.6530594898577, 4110.979445102756, 4147.854825081107, 4195.433616461861, 4215.704900656925, 3997.9600203998752, 4171.6036976487185, 4205.306124489425, 4250.277452833087, 4252.893677658083], "value": 3789.368187336713, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.629490924525, 279.86706314500617, 285.78851649779165, 295.0411163717917, 297.4749567014222, 4569.0, 4677.906441871169, 4758.381410416645, 4764.976175119124, 4773.976130119348, 4489.147062058215, 4565.178267911774, 4582.427196600425, 4621.399218101642, 4622.58396744293, 3464.1639930836695, 3653.2145588698427, 3672.485851980725, 3678.282734866702, 3683.0, 3564.982175089121, 3595.4247320428735, 3607.683195633588, 3618.9819050904707, 3688.944665830015, 3644.7995360255177, 3652.5069115669444, 3657.305112028706, 3684.1894783147663, 3699.833507492156, 3659.432787917877, 3662.9084272893256, 3663.157473781045, 3675.6691897729334, 3681.9815900920325, 3014.668386477486, 3155.984220078908, 3253.8047717137047, 3259.1200375898375, 3268.248302890325, 4562.8631141065825, 4571.634269258451, 4572.359869618256, 4576.7253964761885, 4580.587747102743, 4126.277901367249, 4129.814158362881, 4130.421740956269, 4138.79306034697, 4143.274926887812, 4711.0, 4871.269309603553, 4875.512448755097, 4876.829310974099, 4885.316055752198, 3466.722662187019, 3484.372812893678, 3492.9870337602065, 3493.3013397320383, 3496.5279687242405, 5090.989059321547, 5103.75434808683, 5110.591152707774, 5114.948850511484, 5126.307948426989, 3350.983245083759, 3524.7356448266482, 3562.2163124112653, 3563.0, 3564.180238545149, 3583.6953858922284, 3596.9640303597153, 3607.1162565171703, 3610.1335679436747, 3618.5838628557526, 4110.09577892869, 4119.711620186618, 4121.464209652726, 4129.194807012664, 4130.896727581834, 4852.563269305709, 4865.318855360252, 4873.269009648581, 4884.582131844689, 4885.755712214446, 1181.2144923625865, 1225.9203151795284, 1234.3087870792385, 1245.63876475821, 1250.7748605251143, 770.5338270346472, 790.8695065314158, 802.9156938521371, 809.1301850510724, 809.3080416244144, 3941.837158038328, 3945.6129041929794, 3947.210557888434, 3969.903475289279, 3979.2041591681777, 4421.607193733964, 4421.838385554344, 4421.867343979686, 4437.933430998538, 4466.285394336891, 3893.8637147699696, 3929.901752456154, 3942.7526310003595, 3944.881653550398, 3948.3287841067086, 2363.279199844064, 2370.3955491349598, 2471.270975062361, 2641.9735802642113, 2666.600059946064, 4748.4539277982785, 4769.284607308931, 4769.59458446029, 4774.880627984258, 4775.641826863, 5145.794168233304, 5151.4333423323405, 5159.380874295033, 5167.612429067835, 5178.275041494194, 4643.210654188796, 4757.286407038971, 4758.286257061538, 4776.9761151194025, 4785.59322457595, 5003.124453220745, 5012.644057293066, 5039.445660977363, 5046.697198168122, 5048.772805223847, 4953.2570114483115, 4978.153713868724, 4981.551660350586, 4986.700797952134, 4991.575716064175, 4576.26779715244, 4714.104320179155, 4775.785089671042, 4790.185668436444, 4790.305405716222, 3304.1078908695, 3399.5070714746716, 3530.646935306449, 3553.307105114478, 3565.0552603560595, 4865.0, 5014.674046186986, 5029.270755740324, 5046.823361182341, 5050.77271522775, 4889.731064791471, 4893.926591101065, 4894.975525122351, 4899.579122054564, 4908.631852610997, 4674.205385084611, 4897.926531101965, 4899.951000489949, 4900.803967841246, 4915.778789954532, 4806.831760888352, 4816.736134017006, 4832.420109586872, 4832.613390928647, 4832.9275060873415, 4921.9015619688125, 4929.137400954747, 4934.50654934518, 4948.505149485023, 4986.276989836381, 4636.304554316879, 4717.504662010577, 4835.830745923876, 4850.902981940271, 4868.659193856396], "value": 3640.8404358499383, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.3576002157648, 594.2156353613229, 604.9606775559588, 635.7329921432997, 718.4001358865347, 12349.567765128222, 13053.60839174824, 13060.412281447334, 13061.738765224689, 13063.608091757262, 12922.0, 12925.74148517029, 12981.935090324536, 13066.0, 13463.46146154155, 739.2311995524648, 770.2451597434517, 772.3435080181829, 773.0066864079658, 773.6905237904826, 762.3443838299058, 764.675013119422, 767.8387538616897, 767.9270469305407, 768.7424712721245, 642.5020609027994, 660.8248814064277, 796.1004065406112, 810.1614828652346, 813.0, 806.1736719862159, 808.4664121679722, 814.3241109878786, 814.5153633588005, 814.8329592433566, 591.5918016568597, 591.7100620695871, 592.4223881715336, 592.5052581094791, 592.9762809487615, 9800.264980126447, 10249.84625230622, 12288.631341059783, 12389.876101238962, 12437.253764774143, 12503.874651281429, 13523.323833808368, 13832.723345533133, 13847.238401887893, 14075.155490670593, 10017.198624110126, 10223.539940702613, 10363.689089327332, 10538.789224215472, 10735.731606709895, 3224.742020638343, 3275.737940964741, 3290.276139249361, 3292.0288514888166, 3421.349943510725, 62234.0, 63003.0, 63214.68392658053, 63366.366336336505, 63575.36424635787, 10274.434906080089, 10451.709508360369, 10489.842652360221, 10570.418626975435, 10736.516856741466, 19879.403617891487, 20081.497962551053, 20741.377758667266, 20754.792452075588, 20773.480662983548, 6611.371919667624, 6789.728410863609, 6864.828379290458, 6921.619310937846, 6930.30696930313, 3582.6417358264484, 3603.3153700796765, 3656.3418584654487, 3692.8892133236045, 3731.235096805203, 2693.7440943110373, 2800.453911487281, 2801.579763035561, 2802.523570992936, 2806.059969910062, 478.59080486183814, 480.9302651115569, 481.5882420530396, 490.1324655359993, 498.23272160872574, 556.9303837020373, 596.12962099646, 596.492980966184, 603.8007457539002, 608.6196127420362, 7584.900189472495, 7940.920590794133, 8168.264856162974, 8295.751127466187, 8605.526696031779, 534.6337758635348, 552.5082676417991, 605.2948315212816, 616.349751012677, 626.3736263736264, 3650.3976843821, 3828.7511311764647, 3833.271678381099, 3864.768113913174, 4022.4770779798437, 90516.0, 97404.0, 97763.51118244506, 101879.0, 102130.48934755428, 85220.0, 88006.55996719975, 88431.11568884358, 88489.55755221183, 88835.0, 76105.61947190229, 77088.61455692686, 77519.0, 78105.0, 80286.0, 7267.527610705287, 7309.305615966475, 7385.158834300289, 7579.0, 7619.390448763975, 31447.685523145392, 31813.5227971576, 36923.815380922926, 37955.62044379521, 38241.80879095587, 40770.0, 42417.787911060244, 58296.70851645715, 59588.40411596002, 59745.402545973986, 10972.890271097187, 11125.554977801121, 11284.887151128383, 11502.769944601228, 12116.15186936906, 12880.484780608671, 13110.082294239312, 13219.867801321863, 13231.470741170631, 13558.25429601342, 11643.184977051525, 12113.878861211275, 12158.696032599255, 12180.878191217975, 12248.448819803309, 11383.091897911003, 11941.880581194077, 12190.451429685509, 12202.32887191213, 12203.450844711831, 10330.690079297634, 10719.785604287714, 10855.185861060294, 11373.0, 11380.772384552098, 9818.852717209105, 10077.19382449417, 10199.592016319264, 10241.129503992244, 10513.894861051598, 9683.564239609093, 10298.176145908159, 10448.68653940383, 10477.842832357368, 10511.316764410289], "value": 6444.051869960461, "unit": "score"}], "name": "dromaeo_css", "value": 6113.377704785886, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 117.0, 118.0, 114.0, 115.0, 116.0, 115.0, 116.0, 118.0, 116.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 141.0, 126.0, 177.0, 126.0, 129.0, 130.0, 131.0, 168.0, 131.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 162.0, 162.0, 163.0, 162.0, 162.0, 162.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 112.0, 77.0, 77.0, 78.0, 77.0, 102.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 113.0, 83.0, 83.0, 84.0, 103.0, 83.0, 83.0, 111.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 63.0, 65.0, 64.0, 64.0, 64.0, 74.0, 64.0, 64.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 67.0, 67.0, 66.0, 66.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 83.0, 85.0, 83.0, 84.0, 83.0, 83.0, 89.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 139.0, 139.0, 148.0, 149.0, 138.0, 137.0, 184.0, 138.0], "value": 145.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 174.0, 178.0, 180.0, 174.0, 175.0, 174.0, 175.0, 175.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 69.0, 70.0, 72.0, 73.0, 73.0, 71.0, 69.0, 70.0], "value": 70.8, "unit": "score"}], "name": "kraken", "value": 1558.0, "alertThreshold": 2.0}]} 01:12:07 INFO - Return code: 0 01:12:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:12:07 INFO - # TBPL SUCCESS # 01:12:07 INFO - Running post-action listener: _resource_record_post_action 01:12:07 INFO - [mozharness: 2016-10-04 08:12:07.311368Z] Finished run-tests step (success) 01:12:07 INFO - Running post-run listener: _resource_record_post_run 01:12:07 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 393244672; Read time: 196; Write time: 268700 01:12:07 INFO - TinderboxPrint: CPU usage
13.0% 01:12:07 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 196 01:12:07 INFO - TinderboxPrint: I/O write bytes / time
393,244,672 / 268,700 01:12:07 INFO - TinderboxPrint: CPU idle
8,345.9 (86.9%) 01:12:07 INFO - TinderboxPrint: CPU user
1,204.1 (12.5%) 01:12:07 INFO - TinderboxPrint: Swap in / out
0 / 0 01:12:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 101462016; Read time: 0; Write time: 89088 01:12:07 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291782656; Read time: 184; Write time: 179612 01:12:07 INFO - Running post-run listener: _upload_blobber_files 01:12:07 INFO - Blob upload gear active. 01:12:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:12:07 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 01:12:07 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:12:07 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:12:08 INFO - (blobuploader) - INFO - Open directory for files ... 01:12:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:12:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:12:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:12:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:12:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:12:09 INFO - (blobuploader) - INFO - Done attempting. 01:12:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:12:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:12:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:12:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:12:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:12:09 INFO - (blobuploader) - INFO - Done attempting. 01:12:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:12:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:12:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:12:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:12:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:12:12 INFO - (blobuploader) - INFO - Done attempting. 01:12:12 INFO - (blobuploader) - INFO - Iteration through files over. 01:12:12 INFO - Return code: 0 01:12:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:12:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:12:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9ed3351ad9ed5eb9ad3c160944bf9d019810724e95d695fc7f7ebcbe2eb62b0eb82f1104e74ec57516ecdf3da08978901ee236e29c195a057c455e536c9d6bba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87733548665e55cc11fb5465b294fa4d4697d5faf236cf687abe319cd2ab2ab1d57c9a7210e4207f1cf0479bf2a00dcdaf594d9ef95368488b49ca105c58ac27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82f4a65b8a2384cca32d525e4c6a36257c4e5f54e1bf09f8b6597f9730a63f06d781507709401858c0c9163400945277d985b39c48cf90b94be7bd2e9c222f9e"} 01:12:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:12:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:12:12 INFO - Contents: 01:12:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9ed3351ad9ed5eb9ad3c160944bf9d019810724e95d695fc7f7ebcbe2eb62b0eb82f1104e74ec57516ecdf3da08978901ee236e29c195a057c455e536c9d6bba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87733548665e55cc11fb5465b294fa4d4697d5faf236cf687abe319cd2ab2ab1d57c9a7210e4207f1cf0479bf2a00dcdaf594d9ef95368488b49ca105c58ac27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82f4a65b8a2384cca32d525e4c6a36257c4e5f54e1bf09f8b6597f9730a63f06d781507709401858c0c9163400945277d985b39c48cf90b94be7bd2e9c222f9e"} 01:12:12 INFO - Running post-run listener: copy_logs_to_upload_dir 01:12:12 INFO - Copying logs to upload dir... 01:12:12 INFO - mkdir: /builds/slave/test/build/upload/logs 01:12:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.698851 ========= master_lag: 0.90 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-04 01:12:13.832789) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 01:12:13.836700) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9ed3351ad9ed5eb9ad3c160944bf9d019810724e95d695fc7f7ebcbe2eb62b0eb82f1104e74ec57516ecdf3da08978901ee236e29c195a057c455e536c9d6bba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87733548665e55cc11fb5465b294fa4d4697d5faf236cf687abe319cd2ab2ab1d57c9a7210e4207f1cf0479bf2a00dcdaf594d9ef95368488b49ca105c58ac27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82f4a65b8a2384cca32d525e4c6a36257c4e5f54e1bf09f8b6597f9730a63f06d781507709401858c0c9163400945277d985b39c48cf90b94be7bd2e9c222f9e"} build_url:https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/EbosbMRLTfmt3NPOHcItIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9ed3351ad9ed5eb9ad3c160944bf9d019810724e95d695fc7f7ebcbe2eb62b0eb82f1104e74ec57516ecdf3da08978901ee236e29c195a057c455e536c9d6bba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87733548665e55cc11fb5465b294fa4d4697d5faf236cf687abe319cd2ab2ab1d57c9a7210e4207f1cf0479bf2a00dcdaf594d9ef95368488b49ca105c58ac27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82f4a65b8a2384cca32d525e4c6a36257c4e5f54e1bf09f8b6597f9730a63f06d781507709401858c0c9163400945277d985b39c48cf90b94be7bd2e9c222f9e"}' ========= master_lag: 0.16 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 01:12:14.005419) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 01:12:14.005754) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1475567484.846586-1049427550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 01:12:14.022891) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 01:12:14.024502) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 01:12:14.024871) ========= ========= Total master_lag: 1.12 =========