builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-085 starttime: 1486702623.28 results: success (0) buildid: 20170209190622 builduid: 7174d1fbb4034416bd01352087db1945 revision: 191eead32201661d0f1a80808df7a835d472678d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 20:57:03.280551) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 20:57:03.281224) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 20:57:03.281504) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 20:57:03.300051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:57:03.300341) ========= 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=5c37b704b588aaa989324530000001d0-1486702425.274507-378251389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-09 20:57:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 30.5M=0s 2017-02-09 20:57:03 (30.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140410 ========= master_lag: 0.67 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:57:04.110727) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:57:04.111058) ========= 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=5c37b704b588aaa989324530000001d0-1486702425.274507-378251389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014709 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:57:04.137768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:57:04.138134) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 191eead32201661d0f1a80808df7a835d472678d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 191eead32201661d0f1a80808df7a835d472678d --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=5c37b704b588aaa989324530000001d0-1486702425.274507-378251389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-09 20:57:04,461 truncating revision to first 12 chars 2017-02-09 20:57:04,461 Setting DEBUG logging. 2017-02-09 20:57:04,461 attempt 1/10 2017-02-09 20:57:04,461 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/191eead32201?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 20:57:04,776 unpacking tar archive at: mozilla-beta-191eead32201/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651791 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:57:04.803884) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 20:57:04.804205) ========= script_repo_revision: 191eead32201661d0f1a80808df7a835d472678d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 20:57:04.804669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 20:57:04.804948) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 20:57:04.815415) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-02-09 20:57:04.815713) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=5c37b704b588aaa989324530000001d0-1486702425.274507-378251389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:57:05 INFO - MultiFileLogger online at 20170209 20:57:05 in /builds/slave/test 20:57:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 20:57:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:57:05 INFO - {'append_to_log': False, 20:57:05 INFO - 'base_work_dir': '/builds/slave/test', 20:57:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:57:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:57:05 INFO - 'branch': 'Mozilla-Beta', 20:57:05 INFO - 'buildbot_json_path': 'buildprops.json', 20:57:05 INFO - 'config_files': ('talos/linux_config.py',), 20:57:05 INFO - 'default_actions': ('clobber', 20:57:05 INFO - 'read-buildbot-config', 20:57:05 INFO - 'download-and-extract', 20:57:05 INFO - 'populate-webroot', 20:57:05 INFO - 'create-virtualenv', 20:57:05 INFO - 'install', 20:57:05 INFO - 'run-tests'), 20:57:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:57:05 INFO - 'download_minidump_stackwalk': True, 20:57:05 INFO - 'download_symbols': 'ondemand', 20:57:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:57:05 INFO - 'tooltool.py': '/tools/tooltool.py', 20:57:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:57:05 INFO - '/tools/misc-python/virtualenv.py')}, 20:57:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:57:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:57:05 INFO - 'installer_path': 'installer.exe', 20:57:05 INFO - 'log_level': 'info', 20:57:05 INFO - 'log_name': 'talos', 20:57:05 INFO - 'log_to_console': True, 20:57:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:57:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:57:05 INFO - 'opt_config_files': (), 20:57:05 INFO - 'pip_index': False, 20:57:05 INFO - 'sps_profile': False, 20:57:05 INFO - 'sps_profile_interval': 0, 20:57:05 INFO - 'suite': 'dromaeojs', 20:57:05 INFO - 'system_bits': '32', 20:57:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:57:05 INFO - 'title': 'talos-linux64-ix-085', 20:57:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:57:05 INFO - 'use_talos_json': True, 20:57:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:57:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:57:05 INFO - 'work_dir': 'build'} 20:57:05 INFO - [mozharness: 2017-02-10 04:57:05.234822Z] Running clobber step. 20:57:05 INFO - Running pre-action listener: _resource_record_pre_action 20:57:05 INFO - Running main action method: clobber 20:57:05 INFO - rmtree: /builds/slave/test/build 20:57:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:57:05 INFO - Running post-action listener: _resource_record_post_action 20:57:05 INFO - [mozharness: 2017-02-10 04:57:05.702455Z] Finished clobber step (success) 20:57:05 INFO - [mozharness: 2017-02-10 04:57:05.702555Z] Running read-buildbot-config step. 20:57:05 INFO - Running pre-action listener: _resource_record_pre_action 20:57:05 INFO - Running main action method: read_buildbot_config 20:57:05 INFO - Using buildbot properties: 20:57:05 INFO - { 20:57:05 INFO - "project": "", 20:57:05 INFO - "product": "firefox", 20:57:05 INFO - "script_repo_revision": "production", 20:57:05 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 20:57:05 INFO - "repository": "", 20:57:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 20:57:05 INFO - "buildid": "20170209190622", 20:57:05 INFO - "pgo_build": "True", 20:57:05 INFO - "basedir": "/builds/slave/test", 20:57:05 INFO - "buildnumber": 551, 20:57:05 INFO - "slavename": "talos-linux64-ix-085", 20:57:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:57:05 INFO - "platform": "ubuntu64_hw", 20:57:05 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 20:57:05 INFO - "branch": "mozilla-beta", 20:57:05 INFO - "repo_path": "releases/mozilla-beta", 20:57:05 INFO - "revision": "191eead32201661d0f1a80808df7a835d472678d", 20:57:05 INFO - "stage_platform": "linux64-pgo", 20:57:05 INFO - "builduid": "7174d1fbb4034416bd01352087db1945", 20:57:05 INFO - "slavebuilddir": "test" 20:57:05 INFO - } 20:57:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 20:57:05 INFO - Running post-action listener: _resource_record_post_action 20:57:05 INFO - [mozharness: 2017-02-10 04:57:05.704985Z] Finished read-buildbot-config step (success) 20:57:05 INFO - [mozharness: 2017-02-10 04:57:05.705074Z] Running download-and-extract step. 20:57:05 INFO - Running pre-action listener: _resource_record_pre_action 20:57:05 INFO - Running main action method: download_and_extract 20:57:05 INFO - mkdir: /builds/slave/test/build/tests 20:57:05 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')]} 20:57:05 INFO - trying https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 20:57:05 INFO - Downloading https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 20:57:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:57:06 INFO - Downloaded 1327 bytes. 20:57:06 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 20:57:06 INFO - Using the following test package requirements: 20:57:06 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 20:57:06 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:57:06 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 20:57:06 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:57:06 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 20:57:06 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:57:06 INFO - u'jsshell-linux-x86_64.zip'], 20:57:06 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:57:06 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 20:57:06 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 20:57:06 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:57:06 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 20:57:06 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:57:06 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 20:57:06 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:57:06 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 20:57:06 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:57:06 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 20:57:06 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:57:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 20:57:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:57:06 INFO - Fetch https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 20:57:06 INFO - Http code: 200 20:57:06 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 20:57:06 INFO - x-amz-cf-id: ArYcahddSxCW67R1fPmFQsmV1kSbw01pRA-pLCYlCxs-3ZImMbhHfg== 20:57:06 INFO - x-amz-version-id: ACTDkeBW5vC3Fp_YmD4wGzJYFDE3P6A6 20:57:07 INFO - Expected file size: 21958331 20:57:07 INFO - Obtained file size: 21958331 20:57:11 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:57:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 20:57:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:57:11 INFO - Fetch https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 20:57:11 INFO - Http code: 200 20:57:11 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 20:57:11 INFO - x-amz-cf-id: hbzk1r2NNb6oer8XzppAiqK9sVK5FQe_RTf_UIlH3B-kZVSsB0ENKw== 20:57:11 INFO - x-amz-version-id: ACTDkeBW5vC3Fp_YmD4wGzJYFDE3P6A6 20:57:11 INFO - Expected file size: 21958331 20:57:11 INFO - Obtained file size: 21958331 20:57:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 20:57:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:57:16 INFO - Fetch https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 20:57:16 INFO - Http code: 200 20:57:16 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 20:57:16 INFO - x-amz-cf-id: Yw4u_kXTURyi0yjXmMdNjHNScEzWU1xGvcaISm2bGc90ZerX6n2y2g== 20:57:16 INFO - x-amz-version-id: lO.phrZ9LMEQeLwvigabGjQSzjwonpgg 20:57:17 INFO - Expected file size: 14403005 20:57:17 INFO - Obtained file size: 14403005 20:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:17 INFO - trying https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 20:57:17 INFO - Downloading https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 20:57:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:57:18 INFO - Downloaded 57729158 bytes. 20:57:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 20:57:18 INFO - mkdir: /builds/slave/test/properties 20:57:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:57:18 INFO - Writing to file /builds/slave/test/properties/build_url 20:57:18 INFO - Contents: 20:57:18 INFO - build_url:https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 20:57:19 INFO - Running post-action listener: _resource_record_post_action 20:57:19 INFO - Running post-action listener: set_extra_try_arguments 20:57:19 INFO - [mozharness: 2017-02-10 04:57:19.535877Z] Finished download-and-extract step (success) 20:57:19 INFO - [mozharness: 2017-02-10 04:57:19.536105Z] Running populate-webroot step. 20:57:19 INFO - Running pre-action listener: _resource_record_pre_action 20:57:19 INFO - Running main action method: populate_webroot 20:57:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:57:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:57:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:57:19 INFO - '--tppagecycles', 20:57:19 INFO - '7'], 20:57:19 INFO - 'tests': ['tsvgm']}}, 20:57:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:57:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:57:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:57:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:57:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:57:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:57:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:19 INFO - 'talos_options': ['--disable-e10s'], 20:57:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:57:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:57:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:19 INFO - 'talos_options': ['--disable-e10s'], 20:57:19 INFO - 'tests': ['damp', 'tps']}, 20:57:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:19 INFO - 'tests': ['damp', 'tps']}, 20:57:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:57:19 INFO - 'tests': ['dromaeo_dom']}, 20:57:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:57:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:57:19 INFO - 'tests': ['basic_compositor_video']}, 20:57:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:57:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:57:19 INFO - 'tests': ['a11yr', 20:57:19 INFO - 'ts_paint', 20:57:19 INFO - 'tpaint', 20:57:19 INFO - 'sessionrestore', 20:57:19 INFO - 'sessionrestore_no_auto_restore', 20:57:19 INFO - 'tabpaint']}, 20:57:19 INFO - 'other-e10s': {'tests': ['a11yr', 20:57:19 INFO - 'ts_paint', 20:57:19 INFO - 'tpaint', 20:57:19 INFO - 'sessionrestore', 20:57:19 INFO - 'sessionrestore_no_auto_restore', 20:57:19 INFO - 'tabpaint']}, 20:57:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:57:19 INFO - 'ts_paint', 20:57:19 INFO - 'tpaint', 20:57:19 INFO - 'sessionrestore', 20:57:19 INFO - 'sessionrestore_no_auto_restore', 20:57:19 INFO - 'tabpaint']}, 20:57:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:57:19 INFO - 'ts_paint', 20:57:19 INFO - 'tpaint', 20:57:19 INFO - 'sessionrestore', 20:57:19 INFO - 'sessionrestore_no_auto_restore', 20:57:19 INFO - 'tabpaint']}, 20:57:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:57:19 INFO - 'tests': ['a11yr', 20:57:19 INFO - 'ts_paint', 20:57:19 INFO - 'tpaint', 20:57:19 INFO - 'sessionrestore', 20:57:19 INFO - 'sessionrestore_no_auto_restore', 20:57:19 INFO - 'tabpaint']}, 20:57:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:57:19 INFO - 'tests': ['a11yr', 20:57:19 INFO - 'ts_paint', 20:57:19 INFO - 'tpaint', 20:57:19 INFO - 'sessionrestore', 20:57:19 INFO - 'sessionrestore_no_auto_restore', 20:57:19 INFO - 'tabpaint']}, 20:57:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:57:19 INFO - 'tests': ['tsvgx', 20:57:19 INFO - 'tsvgr_opacity', 20:57:19 INFO - 'tart', 20:57:19 INFO - 'tscrollx', 20:57:19 INFO - 'cart']}, 20:57:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:57:19 INFO - 'tsvgr_opacity', 20:57:19 INFO - 'tart', 20:57:19 INFO - 'tscrollx', 20:57:19 INFO - 'cart']}, 20:57:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:19 INFO - 'talos_options': ['--disable-e10s'], 20:57:19 INFO - 'tests': ['tp5o']}, 20:57:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:19 INFO - 'tests': ['tp5o']}, 20:57:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:19 INFO - 'talos_options': ['--disable-e10s', 20:57:19 INFO - '--xperf_path', 20:57:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:57:19 INFO - 'tests': ['tp5n']}, 20:57:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:19 INFO - 'talos_options': ['--xperf_path', 20:57:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:57:19 INFO - 'tests': ['tp5n']}}, 20:57:19 INFO - 'talos.zip': {'path': '', 20:57:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:57:19 INFO - Running post-action listener: _resource_record_post_action 20:57:19 INFO - [mozharness: 2017-02-10 04:57:19.556304Z] Finished populate-webroot step (success) 20:57:19 INFO - [mozharness: 2017-02-10 04:57:19.556392Z] Running create-virtualenv step. 20:57:19 INFO - Running pre-action listener: _resource_record_pre_action 20:57:19 INFO - Running main action method: create_virtualenv 20:57:19 INFO - Creating virtualenv /builds/slave/test/build/venv 20:57:19 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 20:57:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:57:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:57:19 INFO - Using real prefix '/usr' 20:57:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:57:20 INFO - Installing distribute.............................................................................................................................................................................................done. 20:57:22 INFO - Installing pip.................done. 20:57:22 INFO - Return code: 0 20:57:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:57:22 INFO - Reading from file tmpfile_stdout 20:57:22 INFO - Output received: 20:57:22 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) 20:57:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:22 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 0x7fcab67aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff3f60>, '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 0xff4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff51d0>, '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': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', '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 20:57:22 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 20:57:22 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 20:57:22 INFO - Using env: {'DISPLAY': ':0', 20:57:22 INFO - 'HOME': '/home/cltbld', 20:57:22 INFO - 'LANG': 'en_US.UTF-8', 20:57:22 INFO - 'LANGUAGE': 'en_US:en', 20:57:22 INFO - 'LOGNAME': 'cltbld', 20:57:22 INFO - 'MAIL': '/var/mail/cltbld', 20:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:22 INFO - 'MOZ_NO_REMOTE': '1', 20:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:22 INFO - 'NO_EM_RESTART': '1', 20:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:22 INFO - 'PWD': '/builds/slave/test', 20:57:22 INFO - 'SHELL': '/bin/bash', 20:57:22 INFO - 'SHLVL': '1', 20:57:22 INFO - 'TERM': 'linux', 20:57:22 INFO - 'TMOUT': '86400', 20:57:22 INFO - 'USER': 'cltbld', 20:57:22 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', 20:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:22 INFO - '_': '/tools/buildbot/bin/python'} 20:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:22 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 20:57:22 INFO - Cleaning up... 20:57:22 INFO - Return code: 0 20:57:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:22 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 0x7fcab67aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff3f60>, '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 0xff4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff51d0>, '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': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', '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 20:57:22 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 20:57:22 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 20:57:22 INFO - Using env: {'DISPLAY': ':0', 20:57:22 INFO - 'HOME': '/home/cltbld', 20:57:22 INFO - 'LANG': 'en_US.UTF-8', 20:57:22 INFO - 'LANGUAGE': 'en_US:en', 20:57:22 INFO - 'LOGNAME': 'cltbld', 20:57:22 INFO - 'MAIL': '/var/mail/cltbld', 20:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:22 INFO - 'MOZ_NO_REMOTE': '1', 20:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:22 INFO - 'NO_EM_RESTART': '1', 20:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:22 INFO - 'PWD': '/builds/slave/test', 20:57:22 INFO - 'SHELL': '/bin/bash', 20:57:22 INFO - 'SHLVL': '1', 20:57:22 INFO - 'TERM': 'linux', 20:57:22 INFO - 'TMOUT': '86400', 20:57:22 INFO - 'USER': 'cltbld', 20:57:22 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', 20:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:22 INFO - '_': '/tools/buildbot/bin/python'} 20:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:22 INFO - Downloading/unpacking psutil>=3.1.1 20:57:22 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 20:57:22 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 20:57:22 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 20:57:22 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 20:57:22 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 20:57:22 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 20:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:57:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:57:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:57:24 INFO - Installing collected packages: psutil 20:57:24 INFO - Running setup.py install for psutil 20:57:24 INFO - building 'psutil._psutil_linux' extension 20:57:24 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 20:57:25 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 20:57:25 INFO - building 'psutil._psutil_posix' extension 20:57:25 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 20:57:25 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 20:57:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:57:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:57:25 INFO - Successfully installed psutil 20:57:25 INFO - Cleaning up... 20:57:25 INFO - Return code: 0 20:57:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:57:25 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')]} 20:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:25 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')]} 20:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:25 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 0x7fcab67aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff3f60>, '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 0xff4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff51d0>, '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': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', '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 20:57:25 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 20:57:25 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 20:57:25 INFO - Using env: {'DISPLAY': ':0', 20:57:25 INFO - 'HOME': '/home/cltbld', 20:57:25 INFO - 'LANG': 'en_US.UTF-8', 20:57:25 INFO - 'LANGUAGE': 'en_US:en', 20:57:25 INFO - 'LOGNAME': 'cltbld', 20:57:25 INFO - 'MAIL': '/var/mail/cltbld', 20:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:25 INFO - 'MOZ_NO_REMOTE': '1', 20:57:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:25 INFO - 'NO_EM_RESTART': '1', 20:57:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:25 INFO - 'PWD': '/builds/slave/test', 20:57:25 INFO - 'SHELL': '/bin/bash', 20:57:25 INFO - 'SHLVL': '1', 20:57:25 INFO - 'TERM': 'linux', 20:57:25 INFO - 'TMOUT': '86400', 20:57:25 INFO - 'USER': 'cltbld', 20:57:25 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', 20:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:25 INFO - '_': '/tools/buildbot/bin/python'} 20:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:57:25 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 20:57:25 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 20:57:25 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 20:57:25 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 20:57:25 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 20:57:25 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 20:57:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:57:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:57:27 INFO - Installing collected packages: mozsystemmonitor 20:57:27 INFO - Running setup.py install for mozsystemmonitor 20:57:27 INFO - Successfully installed mozsystemmonitor 20:57:27 INFO - Cleaning up... 20:57:27 INFO - Return code: 0 20:57:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:27 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 0x7fcab67aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff3f60>, '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 0xff4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff51d0>, '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': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', '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 20:57:27 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 20:57:27 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 20:57:27 INFO - Using env: {'DISPLAY': ':0', 20:57:27 INFO - 'HOME': '/home/cltbld', 20:57:27 INFO - 'LANG': 'en_US.UTF-8', 20:57:27 INFO - 'LANGUAGE': 'en_US:en', 20:57:27 INFO - 'LOGNAME': 'cltbld', 20:57:27 INFO - 'MAIL': '/var/mail/cltbld', 20:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:27 INFO - 'MOZ_NO_REMOTE': '1', 20:57:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:27 INFO - 'NO_EM_RESTART': '1', 20:57:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:27 INFO - 'PWD': '/builds/slave/test', 20:57:27 INFO - 'SHELL': '/bin/bash', 20:57:27 INFO - 'SHLVL': '1', 20:57:27 INFO - 'TERM': 'linux', 20:57:27 INFO - 'TMOUT': '86400', 20:57:27 INFO - 'USER': 'cltbld', 20:57:27 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', 20:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:27 INFO - '_': '/tools/buildbot/bin/python'} 20:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:28 INFO - Downloading/unpacking jsonschema==2.5.1 20:57:28 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 20:57:28 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 20:57:28 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 20:57:28 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 20:57:28 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 20:57:28 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 20:57:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:57:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:57:30 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 20:57:30 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 20:57:30 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 20:57:30 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 20:57:30 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 20:57:30 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 20:57:30 INFO - Downloading functools32-3.2.3-2.tar.gz 20:57:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:57:30 INFO - warning: no files found matching '*.txt' 20:57:30 INFO - no previously-included directories found matching 'build' 20:57:30 INFO - no previously-included directories found matching 'dist' 20:57:30 INFO - no previously-included directories found matching '.git*' 20:57:30 INFO - Installing collected packages: jsonschema, functools32 20:57:30 INFO - Running setup.py install for functools32 20:57:30 INFO - warning: no files found matching '*.txt' 20:57:30 INFO - no previously-included directories found matching 'build' 20:57:30 INFO - no previously-included directories found matching 'dist' 20:57:30 INFO - no previously-included directories found matching '.git*' 20:57:30 INFO - Successfully installed jsonschema functools32 20:57:30 INFO - Cleaning up... 20:57:30 INFO - Return code: 0 20:57:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:57:30 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')]} 20:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:30 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')]} 20:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:30 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 0x7fcab67aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff3f60>, '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 0xff4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff51d0>, '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': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', '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 20:57:30 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 20:57:30 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 20:57:30 INFO - Using env: {'DISPLAY': ':0', 20:57:30 INFO - 'HOME': '/home/cltbld', 20:57:30 INFO - 'LANG': 'en_US.UTF-8', 20:57:30 INFO - 'LANGUAGE': 'en_US:en', 20:57:30 INFO - 'LOGNAME': 'cltbld', 20:57:30 INFO - 'MAIL': '/var/mail/cltbld', 20:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:30 INFO - 'MOZ_NO_REMOTE': '1', 20:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:30 INFO - 'NO_EM_RESTART': '1', 20:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:30 INFO - 'PWD': '/builds/slave/test', 20:57:30 INFO - 'SHELL': '/bin/bash', 20:57:30 INFO - 'SHLVL': '1', 20:57:30 INFO - 'TERM': 'linux', 20:57:30 INFO - 'TMOUT': '86400', 20:57:30 INFO - 'USER': 'cltbld', 20:57:30 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', 20:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:30 INFO - '_': '/tools/buildbot/bin/python'} 20:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:57:30 INFO - Cleaning up... 20:57:30 INFO - Return code: 0 20:57:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:57:30 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')]} 20:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:30 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')]} 20:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:30 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 0x7fcab67aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff3f60>, '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 0xff4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff51d0>, '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': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', '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 20:57:30 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 20:57:30 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 20:57:30 INFO - Using env: {'DISPLAY': ':0', 20:57:30 INFO - 'HOME': '/home/cltbld', 20:57:30 INFO - 'LANG': 'en_US.UTF-8', 20:57:30 INFO - 'LANGUAGE': 'en_US:en', 20:57:30 INFO - 'LOGNAME': 'cltbld', 20:57:30 INFO - 'MAIL': '/var/mail/cltbld', 20:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:30 INFO - 'MOZ_NO_REMOTE': '1', 20:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:30 INFO - 'NO_EM_RESTART': '1', 20:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:30 INFO - 'PWD': '/builds/slave/test', 20:57:30 INFO - 'SHELL': '/bin/bash', 20:57:30 INFO - 'SHLVL': '1', 20:57:30 INFO - 'TERM': 'linux', 20:57:30 INFO - 'TMOUT': '86400', 20:57:30 INFO - 'USER': 'cltbld', 20:57:30 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', 20:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:30 INFO - '_': '/tools/buildbot/bin/python'} 20:57:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:31 INFO - Downloading/unpacking blobuploader==1.2.4 20:57:31 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 20:57:31 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 20:57:31 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 20:57:31 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 20:57:31 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 20:57:31 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 20:57:33 INFO - Downloading blobuploader-1.2.4.tar.gz 20:57:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:57:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:57:33 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 20:57:33 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 20:57:33 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 20:57:33 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 20:57:33 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 20:57:33 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 20:57:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:57:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:57:33 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 20:57:33 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 20:57:33 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 20:57:33 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 20:57:33 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 20:57:33 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 20:57:33 INFO - Downloading docopt-0.6.1.tar.gz 20:57:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:57:33 INFO - Installing collected packages: blobuploader, requests, docopt 20:57:33 INFO - Running setup.py install for blobuploader 20:57:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:57:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:57:33 INFO - Running setup.py install for requests 20:57:34 INFO - Running setup.py install for docopt 20:57:34 INFO - Successfully installed blobuploader requests docopt 20:57:34 INFO - Cleaning up... 20:57:34 INFO - Return code: 0 20:57:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:57:34 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')]} 20:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:34 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')]} 20:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:34 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 0x7fcab67aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff3f60>, '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 0xff4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff51d0>, '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': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', '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 20:57:34 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 20:57:34 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 20:57:34 INFO - Using env: {'DISPLAY': ':0', 20:57:34 INFO - 'HOME': '/home/cltbld', 20:57:34 INFO - 'LANG': 'en_US.UTF-8', 20:57:34 INFO - 'LANGUAGE': 'en_US:en', 20:57:34 INFO - 'LOGNAME': 'cltbld', 20:57:34 INFO - 'MAIL': '/var/mail/cltbld', 20:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:34 INFO - 'MOZ_NO_REMOTE': '1', 20:57:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:34 INFO - 'NO_EM_RESTART': '1', 20:57:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:34 INFO - 'PWD': '/builds/slave/test', 20:57:34 INFO - 'SHELL': '/bin/bash', 20:57:34 INFO - 'SHLVL': '1', 20:57:34 INFO - 'TERM': 'linux', 20:57:34 INFO - 'TMOUT': '86400', 20:57:34 INFO - 'USER': 'cltbld', 20:57:34 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', 20:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:34 INFO - '_': '/tools/buildbot/bin/python'} 20:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:57:34 INFO - Running setup.py (path:/tmp/pip-AJgb0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:57:34 INFO - Running setup.py (path:/tmp/pip-LrGOu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:57:34 INFO - Running setup.py (path:/tmp/pip-sB7k0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:57:34 INFO - Running setup.py (path:/tmp/pip-Gb9BkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:57:34 INFO - Running setup.py (path:/tmp/pip-f5NW2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:57:35 INFO - Running setup.py (path:/tmp/pip-OUnFsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:57:35 INFO - Running setup.py (path:/tmp/pip-9H_Ikj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:57:35 INFO - Running setup.py (path:/tmp/pip-WZxC6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:57:35 INFO - Running setup.py (path:/tmp/pip-eqlNqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:57:35 INFO - Running setup.py (path:/tmp/pip-NpAbor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:57:35 INFO - Running setup.py (path:/tmp/pip-xAqVeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:57:35 INFO - Running setup.py (path:/tmp/pip-LPh0ET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:57:35 INFO - Running setup.py (path:/tmp/pip-MxJRcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:57:35 INFO - Running setup.py (path:/tmp/pip-mt2RiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:35 INFO - Running setup.py (path:/tmp/pip-6B9KSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:57:35 INFO - Running setup.py (path:/tmp/pip-F6Jtqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:57:35 INFO - Running setup.py (path:/tmp/pip-8vAThg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:57:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:57:35 INFO - Running setup.py install for manifestparser 20:57:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:57:36 INFO - Running setup.py install for mozcrash 20:57:36 INFO - Running setup.py install for mozdebug 20:57:36 INFO - Running setup.py install for mozdevice 20:57:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:57:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:57:36 INFO - Running setup.py install for mozfile 20:57:36 INFO - Running setup.py install for mozhttpd 20:57:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:57:36 INFO - Running setup.py install for mozinfo 20:57:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:57:36 INFO - Running setup.py install for mozInstall 20:57:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:57:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:57:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:57:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:57:36 INFO - Running setup.py install for mozleak 20:57:36 INFO - Running setup.py install for mozlog 20:57:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:57:36 INFO - Running setup.py install for moznetwork 20:57:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:57:37 INFO - Running setup.py install for mozprocess 20:57:37 INFO - Running setup.py install for mozprofile 20:57:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:57:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:57:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:57:37 INFO - Running setup.py install for mozrunner 20:57:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:57:37 INFO - Running setup.py install for mozscreenshot 20:57:37 INFO - Running setup.py install for moztest 20:57:37 INFO - Running setup.py install for mozversion 20:57:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:57:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:57:37 INFO - Cleaning up... 20:57:37 INFO - Return code: 0 20:57:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:37 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 0x7fcab67aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff3f60>, '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 0xff4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff51d0>, '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': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', '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 20:57:37 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 20:57:37 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 20:57:37 INFO - Using env: {'DISPLAY': ':0', 20:57:37 INFO - 'HOME': '/home/cltbld', 20:57:37 INFO - 'LANG': 'en_US.UTF-8', 20:57:37 INFO - 'LANGUAGE': 'en_US:en', 20:57:37 INFO - 'LOGNAME': 'cltbld', 20:57:37 INFO - 'MAIL': '/var/mail/cltbld', 20:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:37 INFO - 'MOZ_NO_REMOTE': '1', 20:57:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:37 INFO - 'NO_EM_RESTART': '1', 20:57:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:37 INFO - 'PWD': '/builds/slave/test', 20:57:37 INFO - 'SHELL': '/bin/bash', 20:57:37 INFO - 'SHLVL': '1', 20:57:37 INFO - 'TERM': 'linux', 20:57:37 INFO - 'TMOUT': '86400', 20:57:37 INFO - 'USER': 'cltbld', 20:57:37 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', 20:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:37 INFO - '_': '/tools/buildbot/bin/python'} 20:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:57:37 INFO - Running setup.py (path:/tmp/pip-XibgbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:57:37 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)) 20:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:57:37 INFO - Running setup.py (path:/tmp/pip-ESqXqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:57:38 INFO - Running setup.py (path:/tmp/pip-PwNjqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:57:38 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)) 20:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:57:38 INFO - Running setup.py (path:/tmp/pip-vjFEQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:57:38 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)) 20:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:57:38 INFO - Running setup.py (path:/tmp/pip-ILJalh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:57:38 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)) 20:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:57:38 INFO - Running setup.py (path:/tmp/pip-cOfG8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:57:38 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)) 20:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:57:38 INFO - Running setup.py (path:/tmp/pip-3xU25p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:57:38 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)) 20:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:57:38 INFO - Running setup.py (path:/tmp/pip-JpZ25q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:57:38 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)) 20:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:57:38 INFO - Running setup.py (path:/tmp/pip-Ld_oUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:57:38 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)) 20:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:57:38 INFO - Running setup.py (path:/tmp/pip-QaFUiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:57:38 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)) 20:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:57:38 INFO - Running setup.py (path:/tmp/pip-2A55q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:57:38 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)) 20:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:57:38 INFO - Running setup.py (path:/tmp/pip-EDC6oK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:57:38 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)) 20:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:57:38 INFO - Running setup.py (path:/tmp/pip-OS0Qrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:57:38 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)) 20:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:57:38 INFO - Running setup.py (path:/tmp/pip-QLItlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:38 INFO - Running setup.py (path:/tmp/pip-6g9OfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:39 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)) 20:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:57:39 INFO - Running setup.py (path:/tmp/pip-0o34Rm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:57:39 INFO - Running setup.py (path:/tmp/pip-3SzdXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:57:39 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)) 20:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:57:39 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)) 20:57:39 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)) 20:57:39 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)) 20:57:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:57:39 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 20:57:39 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 20:57:39 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 20:57:39 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 20:57:39 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 20:57:39 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 20:57:41 INFO - Downloading blessings-1.6.tar.gz 20:57:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:57:41 INFO - Installing collected packages: blessings 20:57:41 INFO - Running setup.py install for blessings 20:57:41 INFO - Successfully installed blessings 20:57:41 INFO - Cleaning up... 20:57:41 INFO - Return code: 0 20:57:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:57:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:57:41 INFO - Reading from file tmpfile_stdout 20:57:41 INFO - Current package versions: 20:57:41 INFO - argparse == 1.2.1 20:57:41 INFO - blessings == 1.6 20:57:41 INFO - blobuploader == 1.2.4 20:57:41 INFO - docopt == 0.6.1 20:57:41 INFO - functools32 == 3.2.3-2 20:57:41 INFO - jsonschema == 2.5.1 20:57:41 INFO - manifestparser == 1.1 20:57:41 INFO - mozInstall == 1.12 20:57:41 INFO - mozcrash == 1.0 20:57:41 INFO - mozdebug == 0.1 20:57:41 INFO - mozdevice == 0.48 20:57:41 INFO - mozfile == 1.2 20:57:41 INFO - mozhttpd == 0.7 20:57:41 INFO - mozinfo == 0.9 20:57:41 INFO - mozleak == 0.1 20:57:41 INFO - mozlog == 3.4 20:57:41 INFO - moznetwork == 0.27 20:57:41 INFO - mozprocess == 0.23 20:57:41 INFO - mozprofile == 0.28 20:57:41 INFO - mozrunner == 6.13 20:57:41 INFO - mozscreenshot == 0.1 20:57:41 INFO - mozsystemmonitor == 0.3 20:57:41 INFO - moztest == 0.8 20:57:41 INFO - mozversion == 1.4 20:57:41 INFO - psutil == 3.1.1 20:57:41 INFO - requests == 1.2.3 20:57:41 INFO - wsgiref == 0.1.2 20:57:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:57:41 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')]} 20:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:41 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')]} 20:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:41 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 0x7fcab67aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff3f60>, '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 0xff4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff51d0>, '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': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', '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 20:57:41 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 20:57:41 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 20:57:41 INFO - Using env: {'DISPLAY': ':0', 20:57:41 INFO - 'HOME': '/home/cltbld', 20:57:41 INFO - 'LANG': 'en_US.UTF-8', 20:57:41 INFO - 'LANGUAGE': 'en_US:en', 20:57:41 INFO - 'LOGNAME': 'cltbld', 20:57:41 INFO - 'MAIL': '/var/mail/cltbld', 20:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:41 INFO - 'MOZ_NO_REMOTE': '1', 20:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:41 INFO - 'NO_EM_RESTART': '1', 20:57:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:41 INFO - 'PWD': '/builds/slave/test', 20:57:41 INFO - 'SHELL': '/bin/bash', 20:57:41 INFO - 'SHLVL': '1', 20:57:41 INFO - 'TERM': 'linux', 20:57:41 INFO - 'TMOUT': '86400', 20:57:41 INFO - 'USER': 'cltbld', 20:57:41 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', 20:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:41 INFO - '_': '/tools/buildbot/bin/python'} 20:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:41 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)) 20:57:41 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)) 20:57:41 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)) 20:57:41 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)) 20:57:41 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)) 20:57:41 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)) 20:57:41 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)) 20:57:41 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)) 20:57:41 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)) 20:57:41 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)) 20:57:41 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)) 20:57:41 INFO - Cleaning up... 20:57:41 INFO - Return code: 0 20:57:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:57:41 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')]} 20:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:41 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')]} 20:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:41 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 0x7fcab67aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff3f60>, '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 0xff4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff51d0>, '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': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', '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 20:57:41 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 20:57:41 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 20:57:41 INFO - Using env: {'DISPLAY': ':0', 20:57:41 INFO - 'HOME': '/home/cltbld', 20:57:41 INFO - 'LANG': 'en_US.UTF-8', 20:57:41 INFO - 'LANGUAGE': 'en_US:en', 20:57:41 INFO - 'LOGNAME': 'cltbld', 20:57:41 INFO - 'MAIL': '/var/mail/cltbld', 20:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:41 INFO - 'MOZ_NO_REMOTE': '1', 20:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:41 INFO - 'NO_EM_RESTART': '1', 20:57:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:41 INFO - 'PWD': '/builds/slave/test', 20:57:41 INFO - 'SHELL': '/bin/bash', 20:57:41 INFO - 'SHLVL': '1', 20:57:41 INFO - 'TERM': 'linux', 20:57:41 INFO - 'TMOUT': '86400', 20:57:41 INFO - 'USER': 'cltbld', 20:57:41 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', 20:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:41 INFO - '_': '/tools/buildbot/bin/python'} 20:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:57:42 INFO - Cleaning up... 20:57:42 INFO - Return code: 0 20:57:42 INFO - Running post-action listener: _resource_record_post_action 20:57:42 INFO - Running post-action listener: _start_resource_monitoring 20:57:42 INFO - Starting resource monitoring. 20:57:42 INFO - [mozharness: 2017-02-10 04:57:42.146390Z] Finished create-virtualenv step (success) 20:57:42 INFO - [mozharness: 2017-02-10 04:57:42.146895Z] Running install step. 20:57:42 INFO - Running pre-action listener: _resource_record_pre_action 20:57:42 INFO - Running main action method: install 20:57:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:57:42 INFO - Reading from file tmpfile_stdout 20:57:42 INFO - Detecting whether we're running mozinstall >=1.0... 20:57:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:57:42 INFO - Reading from file tmpfile_stdout 20:57:42 INFO - Output received: 20:57:42 INFO - Usage: mozinstall [options] installer 20:57:42 INFO - Options: 20:57:42 INFO - -h, --help show this help message and exit 20:57:42 INFO - -d DEST, --destination=DEST 20:57:42 INFO - Directory to install application into. [default: 20:57:42 INFO - "/builds/slave/test"] 20:57:42 INFO - --app=APP Application being installed. [default: firefox] 20:57:42 INFO - mkdir: /builds/slave/test/build/application 20:57:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:57:56 INFO - Reading from file tmpfile_stdout 20:57:56 INFO - Output received: 20:57:56 INFO - /builds/slave/test/build/application/firefox/firefox 20:57:56 INFO - Running post-action listener: _resource_record_post_action 20:57:56 INFO - [mozharness: 2017-02-10 04:57:56.064412Z] Finished install step (success) 20:57:56 INFO - [mozharness: 2017-02-10 04:57:56.064654Z] Running run-tests step. 20:57:56 INFO - Running pre-action listener: _resource_record_pre_action 20:57:56 INFO - Running main action method: run_tests 20:57:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:57:56 INFO - Python 2.7.3 20:57:56 INFO - Return code: 0 20:57:56 INFO - grabbing minidump binary from tooltool 20:57: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')]} 20:57:56 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 0xff3f60>, '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 0xff4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff51d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:57:56 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 20:57:56 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 20:57:56 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 20:57:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:57:56 INFO - Return code: 0 20:57:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:57:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:57:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:57:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:57:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:57:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 20:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-085 --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 20:57:56 INFO - Using env: {'DISPLAY': ':0', 20:57:56 INFO - 'HOME': '/home/cltbld', 20:57:56 INFO - 'LANG': 'en_US.UTF-8', 20:57:56 INFO - 'LANGUAGE': 'en_US:en', 20:57:56 INFO - 'LOGNAME': 'cltbld', 20:57:56 INFO - 'MAIL': '/var/mail/cltbld', 20:57:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:57:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:56 INFO - 'MOZ_NO_REMOTE': '1', 20:57:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:56 INFO - 'NO_EM_RESTART': '1', 20:57:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:56 INFO - 'PWD': '/builds/slave/test', 20:57:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:57:56 INFO - 'SHELL': '/bin/bash', 20:57:56 INFO - 'SHLVL': '1', 20:57:56 INFO - 'TERM': 'linux', 20:57:56 INFO - 'TMOUT': '86400', 20:57:56 INFO - 'USER': 'cltbld', 20:57:56 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1486702425.274507-378251389', 20:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:56 INFO - '_': '/tools/buildbot/bin/python'} 20:57:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 20:57:56 INFO - mozversion application_buildid: 20170209190622 20:57:56 INFO - mozversion application_changeset: 191eead32201661d0f1a80808df7a835d472678d 20:57:56 INFO - mozversion application_display_name: Firefox 20:57:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:57:56 INFO - mozversion application_name: Firefox 20:57:56 INFO - mozversion application_remotingname: firefox 20:57:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:57:56 INFO - mozversion application_vendor: Mozilla 20:57:56 INFO - mozversion application_version: 52.0 20:57:56 INFO - mozversion platform_buildid: 20170209190622 20:57:56 INFO - mozversion platform_changeset: 191eead32201661d0f1a80808df7a835d472678d 20:57:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:57:56 INFO - mozversion platform_version: 52.0 20:57:56 INFO - using testdate: 1486702676 20:57:56 INFO - actual date: 1486702676 20:57:56 INFO - starting webserver on 'localhost:40552' 20:57:56 INFO - SUITE-START | Running 2 tests 20:57:56 INFO - TEST-START | dromaeo_css 20:57:56 INFO - operating with platform_type : linux_ 20:57:56 INFO - Initialising browser for dromaeo_css test... 20:57:56 INFO - TEST-INFO | started process 14808 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyeRkl2/profile http://localhost:40552/getInfo.html) 20:58:00 INFO - PROCESS | 14808 | __metrics Screen width/height:1600/1200 20:58:00 INFO - PROCESS | 14808 | colorDepth:24 20:58:00 INFO - PROCESS | 14808 | Browser inner width/height: 1024/697 20:58:00 INFO - PROCESS | 14808 | __metrics 20:58:01 INFO - PROCESS | 14808 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:58:01 INFO - PROCESS | 14808 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:58:01 INFO - PROCESS | 14808 | console.error: PushService: 20:58:01 INFO - PROCESS | 14808 | stateChangeProcessEnqueue: Error transitioning state 20:58:01 INFO - PROCESS | 14808 | UnknownError 20:58:02 INFO - TEST-INFO | 14808: exit 0 20:58:02 INFO - Browser initialized. 20:58:02 INFO - Running cycle 1/1 for dromaeo_css test... 20:58:02 INFO - TEST-INFO | started process 14903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyeRkl2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:58:13 INFO - PROCESS | 14903 | RSS: Main: 141799424 20:58:13 INFO - PROCESS | 14903 | 21:01:15 INFO - PROCESS | 14903 | Cycle 1(1): loaded http://localhost:40552/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40552/tests/dromaeo/cssquery-ext.html) 21:01:16 INFO - PROCESS | 14903 | RSS: Main: 239947776 21:01:16 INFO - PROCESS | 14903 | 21:04:18 INFO - PROCESS | 14903 | Cycle 1(1): loaded http://localhost:40552/tests/dromaeo/cssquery-ext.html (next: http://localhost:40552/tests/dromaeo/cssquery-jquery.html) 21:04:19 INFO - PROCESS | 14903 | RSS: Main: 230072320 21:04:19 INFO - PROCESS | 14903 | 21:07:21 INFO - PROCESS | 14903 | Cycle 1(1): loaded http://localhost:40552/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40552/tests/dromaeo/cssquery-mootools.html) 21:07:22 INFO - PROCESS | 14903 | RSS: Main: 217759744 21:07:22 INFO - PROCESS | 14903 | 21:10:23 INFO - PROCESS | 14903 | Cycle 1(1): loaded http://localhost:40552/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40552/tests/dromaeo/cssquery-prototype.html) 21:10:24 INFO - PROCESS | 14903 | RSS: Main: 217804800 21:10:24 INFO - PROCESS | 14903 | 21:13:27 INFO - PROCESS | 14903 | Cycle 1(1): loaded http://localhost:40552/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40552/tests/dromaeo/cssquery-yui.html) 21:13:27 INFO - PROCESS | 14903 | RSS: Main: 176762880 21:13:27 INFO - PROCESS | 14903 | 21:16:29 INFO - PROCESS | 14903 | Cycle 1(1): loaded http://localhost:40552/tests/dromaeo/cssquery-yui.html (next: http://localhost:40552/tests/dromaeo/cssquery-dojo.html) 21:16:30 INFO - PROCESS | 14903 | RSS: Main: 261111808 21:16:30 INFO - PROCESS | 14903 | 21:16:30 INFO - PROCESS | 14903 | __start_tp_report 21:16:30 INFO - PROCESS | 14903 | _x_x_mozilla_page_load 21:16:30 INFO - PROCESS | 14903 | _x_x_mozilla_page_load_details 21:16:30 INFO - PROCESS | 14903 | |i|pagename|runs| 21:16:30 INFO - PROCESS | 14903 | |0;dojo.html;3197.744180465563;3226.4998925166606;3245.4807230843053;3257.348530293941;3283.720883724884;5525.944740552603;5545.528630066444;5570.526505247049;5616.606837521375;5635.887282254353;5596.300462442195;5656.745446454909;5660.066089095294;5668.319801623811;5708.914366284509;5057.595392368602;5131.358580177478;5166.380034395859;5168.508991645806;5213;4894.1679914414635;4910.852674419773;5193.558547523465;5214.322138122057;5218.686878787266;4995.400551933773;5020.146575082244;5048.545630893219;5115.897682046357;5162.483751624845;5160.354955630546;5177.119889618773;5224.39919409269;5233.5551478124025;5238.842834714965;4832.081904438145;4839.225723884161;5086.084504789136;5115.437301896788;5169.302144210521;5362.061639213122;5404.081306177959;5479.972600136974;5495.175723641486;5503.724813759296;5925.525957923356;5981.162637230791;6018.307894592134;6018.819435416901;6031.698415079229;5756.136579513065;5808.506276966463;6031.276246850406;6054.091886217058;6062.514998800129;5504.366997795225;5568.972155139199;5569.164625306236;5570.387257401682;5591.4688104629995;6102.847428814315;6108.3280839107665;6115.877682446326;6127.4485296322655;6127.938720612826;5668.943310566841;5727.77088916447;5858.384869588632;5863.472287494146;5875.265591801025;5951.464368206795;5993;6011.1884895539415;6018.277806663141;6025.216721826135;5954.523638108941;5960.7019649017375;5967;5969.79105731306;5970.104484327386;5915.585908986416;5975.970120149372;5984.970075149597;5991.430814072656;6006.039033754579;4464.441944756905;4486.910261794746;4552.430946131733;4570.154521413549;4579.977100114545;4089.5900437778264;4092.46797916269;4092.897677558085;4097.590240975938;4115.588441155861;5637.23897273871;5638.126090455986;5639;5656.208130861683;5686.744096515667;5691.8861622768145;5741.368449470555;5886.293644762571;5934.43622855828;5963.4334738199805;5617.43825617435;5636.689982051026;5637.46444087811;5657.773689052474;5671.546276297886;5147.6396652234735;5155.767990440364;5158.690478571298;5161.561267292323;5212.947870521322;5922.555808314308;5982;6057.757689692539;6068.787592434332;6130.509559235251;6003.219581454558;6078.240219972504;6107.572469927062;6118.174046503665;6118.479929206067;6173.290071641639;6184.856834791036;6190.473809726223;6204.906926396017;6211.254649442096;5575.2473416088305;5930.199423077829;5932.436418540232;5941.494972927349;5963.522918166623;5791.623544469596;5915.142304365757;5926.318473375444;5957.91063134062;6047.183630209865;5804.854878627899;5837.883242335214;5856.59003869725;5861.472467477947;5866.5893387464175;5803.8549036274435;5812.418758124154;5840.970795145997;5852.122181672783;5862.12068189775;5642.633228840113;5699.230603868425;5701.201831743642;5706.914396284142;5736.053551164178;5811.099279611667;5814.76740930358;5818;5836.620619659709;5845.09401042839;5580.274564306615;5620.578456615688;5636.239107720569;5690.089585666274;5709.857253568528 21:16:30 INFO - PROCESS | 14903 | |1;ext.html;579.8637320229745;614.0911451052442;638.9616623002619;658.4173006888902;658.5850913924227;33694;45266.547334526644;45268.54731452685;45507.54492455075;45521.77239113808;45047.77476112623;45507;45595;45619.77190114045;45638.771806141005;8362.58187090646;9061.637534498628;9206.585703643352;9217.769555761126;9221.077892210793;8476.78808029798;10712.089472394817;11107.000369966701;11108.666739997812;11383.94308028463;11214.607488737896;11259.831102533468;11281.266717663366;11294.265872718248;11346.60286889959;11016.614418495354;11061.778764424747;11064.668059958214;11071.446427678664;11071.889281107166;10984.670459886216;11101.333919964827;11103.611373601885;11103.944480277547;11114.888851111466;43532;43812.561874381485;43851.342229866576;43870.780646096566;43899;3330.134165117063;3392.3045775615938;3447.3105378924065;3524.559430071241;3871.5354157500997;32019.679803202136;32407.83796081028;32426;32576.185595360068;33003.00990970275;3440.535527703753;3502;3534.469829525566;3554.697850682695;3612.5303710517464;331384;334554;335895;336966;337279;61601.38398615956;61911.6904415484;61942.38057619366;61965.69017154886;62036;35286;35950.46074308887;36024.27951441009;36079;36122.45816312757;18867.43397698044;19064;19081.2367505301;19087.809121908882;19094.904525477283;13490;13703.862961370258;14611.123332600078;14700.705985880437;14753;19553.63024773948;20195.394138175583;20495.69256461154;20507;20550.794492054887;7587.127480339721;7632.537716618225;7682.769516914502;7766.88349674744;7772.378209743207;867.5922316511229;876.7545087375545;907.9046700096527;1019.8929112443235;1034.7878684869584;29527.85236073849;30304.84847575792;30322.84838575837;30333.69666303353;31443;1023.9078482936571;1041.963246569668;1046.26238501856;1087.9401632910108;1106.4523061084653;15310.846891530942;15983.44057957966;16128.002871987259;16169.110698911672;16395.83604163943;530213.3489332605;536059;536119;536668;536706;60418.0937285941;60884;61035.694821525605;61175.38824611786;61196;1308.770965081126;1353.824002879639;1397.7903314502703;1401.7126489069717;1429.9642508937152;28782;31104.377912442076;31371.84314078415;32235;32591.674083258862;51242;56609.43390566207;57792.13311800242;58246.41753582579;64408;425692;428542;430265;430511;430633;35928.64071359253;36515.53937842457;39235.803820981855;40630;42265.57734422616;44822.77588612036;44968.55031449644;44971;45064.54935450735;45165;39117.217655646156;39118;39178.60821391863;39399.80300098596;40157.397639034854;38010;38289.23421531609;39645.60354396534;39780.20439591134;39890;38593.2281354377;39010.41484377794;39393.2121357577;39734.40398394084;39860;33440.498392523645;35459.64540354563;36124.4581331275;36207.094822629646;36438.8178059108;27173.320666983484;27445;27482.45035099327;27495.725042750117;27500.724992750616 21:16:30 INFO - PROCESS | 14903 | |2;jquery.html;424.4927311862324;426.8740721487161;428.63780105810577;432.30183254044726;434.31595237500943;18077.728834067482;18430.17064232111;19158.233670653193;19398;19438.902805485952;18951.526211844677;19132.23471061156;19148.80851191488;19209.807901920976;19643.901780491076;5509.201165830962;5894.646321220741;5932.436418540232;5933.821985340447;5938.376470470603;5763.164341170528;5809.825705228829;5930.792422265222;5951.166836642873;5957.225560677106;6046.123312119762;6101.511879049665;6119.143319935212;6123.785667501638;6125.142480052797;5826.563007774392;5998.190244317005;6039.184710064129;6045.879082418371;6102.481289090432;5855.853603659943;5882.3823498532465;5891.646501209942;5893.528517718572;5893.58744887858;13904.374303156383;14177.716445671029;14274.429022839075;14275.714485710332;14323.498677546237;2246.269962262255;2320.953580928389;2323.4191452136965;2334.556434277482;2444.2422848916717;10457.895421045845;10627.84058239127;10650.4142272175;10694.144468442506;10929.617463388744;1812.2298023340159;1947.8928658923896;1971.428285797117;2051.2205361962506;2079.6672532394896;79104;81059.5947020267;81777.59111204406;82467.58766206191;82991.585042075;11054.557817687364;11108.722281943015;11192.552297908156;11212.159088068427;11551.191416600925;16093.517194484184;16099.919500402657;16122;16131.919340403223;16132.112733799519;8569.571521423904;8650.264727498234;8713.607887645072;8809.867851982226;8837.20465158126;8392.79018024542;8395.454295470774;8579.356548258906;8628.22345988864;8635.395522313504;4864.391951006124;4914.36113305268;4939.728314942641;4966.652334336634;5070.442251352349;2045.3557129504159;2075.1284460526617;2104.2950611544998;2105.77889321619;2111.7571479279773;939.3424602778083;957.9377340472847;966.0773960867355;972.6547075788135;988.9950550247347;17525.386611468537;18319.084045797656;18399.632007359778;18464;18596.44210673682;911.562450023979;938.7981583959481;960.1478985582861;970.4710932541782;983.8130755156498;9611.759706007406;10044.497775111215;10336.121429678411;10350;10352.844707329396;431897;438670;463563;464488;465307;88097;88474;88505;89264;90994;983.4738414947968;1025.7538190834146;1026.8049070676548;1027.732789474727;1034.6585626743308;14503.92748036253;15601.219939003231;15730;15732.764008539652;16105;37858.24283514369;42467;43686.56313436952;44884.77557612191;44921;47971;55892;55976;56031;57061.71469142628;7676.501027433199;7990.720324788605;8068.273855353046;8098.473599216032;8174.059983102019;10152.847707284249;11466.541338346373;11828.645140645795;12040.578579749666;12088.516459341528;10399.220058495794;10466.110380617733;10549.736256593647;10702.357858528514;10762.838557421488;9797.657082002095;9800.65697700577;10137.493125343555;10335.638252661121;10557.9472102639;10547.78904421892;10656.307340022873;10739.516721747385;10932.836007459735;10961.945190273998;7686.884696729442;7908.288254057163;7942.682292708227;7955.443118981616;7997.520148791091;10556.577736890438;10640.414777187329;10673;10715.089217416607;10985.780284394426 21:16:30 INFO - PROCESS | 14903 | |3;mootools.html;1333.4199623163931;1504.3982407037183;1522.7715842623606;1645.7366821308592;1808.91859866306;7873.527588344703;8603.354748393873;8894.021657617657;8899.644014239431;9193.58628861701;9058.139476749715;9123.54382280885;9125.133112354315;9131.269498440126;9135.725928222148;2472.3819045238693;2499.0253801017616;2502.1617758051075;2502.8998840046374;2506.0351764570682;2462.9876850615724;2511.4223728542447;2511.4474815540643;2513.924582262535;2516.421223118675;2452.4236804350962;2456.1649039326626;2464.581021226387;2464.7658472445087;2467.062516243825;2401.9159329423474;2407.9518409631796;2425.0784701813373;2432.0879670123704;2432.7688869557364;2411.44536756547;2434.464417828093;2452.8773561321864;2454.864982425966;2456.2017344362976;8723.869141962876;8907.688230911952;9089.63641454341;9091.63633454661;9099.408538444979;5451.127819548853;5675.6878371689545;5679.659220446745;5681.971590142023;5688.715564221772;3392.08413728292;3523.700485458739;3581.3553560359123;3634.018814919983;3659.2864391443677;1073.9677809665645;1105.9447027648666;1112.7329440934197;1134.7730453909169;1156.5316047000895;12266.81599776004;12527.624171274876;12535;12573.302604148506;12605.495780168781;4427.800748966304;4655.650826188049;4689.109069276895;4723.48041715411;4758.3100450434495;10005.099541041342;10009.599616015277;10012.599496020222;10020.198384129399;10022.949885250528;5487.780488780484;5490.670559766347;5493.258410114663;5493.917591236134;5494.835154945358;4456.977715111404;4551.613112885376;5132.717700526507;5157.871053223699;5180.663256888291;4131.0679611650485;4144.937825932613;4209.642180414699;4240.363945408213;4242.915141697149;1270.5616562285998;1301.5639760680278;1309.4107651556837;1311.6196303072002;1326.5423428917202;679.6363945289246;776.4099284543787;781.4998401023349;783.4554984285867;792.180093603118;5461.481159289861;5567.498925096761;5628.296462942132;5633.211350410946;5679.6876171810945;459.4165409929438;474.8005837548238;480.2148487223415;481.0787342239642;482.90583336249796;3681.318955993096;3685.8341374638208;3702.7037836972977;3706.221693444353;3731.6454936781506;10859.891401086046;11271.154663400113;11356.829647555292;11431.59989400367;11435.142364322543;11308.982191602796;11327.546898124148;11330.37682927447;11331.830022549504;11335.263207891461;8437.831243375222;8511.574421279036;8584.613692383733;8652.913470865336;8653.26447251978;5522.116461366162;5599.80400685974;5675.404082571271;5690.971545142248;5715.39988301239;10221.386716797017;10328.638497652546;10331.84502232452;10500.422476763852;10513.421761803174;10687.946560267148;10688.038076572835;10780.568777248822;10780.676579702622;10793.136549076213;6674.799756007327;6836.418904393182;6839.760608378683;7355.8161045974275;7449.255074492507;7666.348360389206;8180.100188979089;8223.506589604644;8438.156184381513;8441.36689748259;7413.962930185315;7432.442566807403;7534.773956781305;7554.924450755422;7648.732294369893;7571.507851989603;7581.962090189734;7604.277593628596;7658.042744656918;7682;6582.670866456754;6730.822106131505;6739.494537909578;6741.966290168518;6742.8651426972165;4951.801927922843;4996.2505624156665;5032.6980381177245;5040.117979353525;5199.92200116991;4831.95168048315;4883.6093112551625;4897;5006.949930500648;5065.620078494201 21:16:30 INFO - PROCESS | 14903 | |4;prototype.html;334.23460275968034;343.56367413385;351.715110760284;353.85315094235887;357.10545084563165;5411.91882121768;5451.454854514546;5460.044492213867;5460.215290201996;5475.890482190353;5138;5214.921776173361;5234.450382709818;5331.626786124973;5395.7032363220005;4212.157568486315;4246.57534246576;4261.169072030955;4264.317709166534;4270.572942705736;4265.573442655741;4267.530571637118;4281.785910704468;4282.379055037018;4286.592773686495;4125.257453658341;4231.640310573605;4241.172971270604;4252.447181866353;4269.786510674469;4228.682848786353;4232.978670263232;4242.384854196124;4255.170241802834;4263.211305908401;3808.3906574947873;3808.409696497047;3810.5236845394325;3825.8469661213517;3828.636279553438;5019.548240658358;5228.294180285651;5245.86885327866;5254.52709256165;5281.260623512711;4865.8783530411665;4872.3909511311085;4881.609471242292;4890.877728056791;4891.486393928657;5602.24369710088;5652.265205523297;5655.547556195535;5659.943400565983;5666.470053085685;4030.2544029354663;4094.6928980326593;4133.42132101506;4136.152088821785;4149.3775933609895;5811.564132690065;5825.533957283407;5832.591718579701;5836.066229403317;5841.4450627190345;4195.811188496525;4206.684498662551;4207.410962465257;4211.1998720243055;4225.176090662291;4159.667226621863;4247.110036033997;4303.139372125587;4304.612584867377;4306.849260275938;4827.444843842933;4838.395200599925;4840.201366774443;4875.829345972945;4883.096627123993;5628.718564071862;5649.0396632572565;5719.48524632785;5734.627249228787;5735.483806457439;1407.7254935287726;1413;1413.1450472464217;1421;1424.9740187065297;977.9413235205768;982.9262805289488;985.9556319965619;988.313122379939;1005.2410430125354;5170.896582068338;5183.222516622537;5191.32512773337;5208.218767184952;5210.843674689765;5517.806876759294;5542.972285138549;5567.888642227133;5576.637518561281;5596.132599447093;5012.974935125301;5212.6638951071345;5226.97386513065;5255.894882102413;5260.579153667697;2928.7656987440955;2939.5884576159356;2939.9412011759646;2947.437857935298;2952.188148259203;5597.74810133545;5618.438156184349;5625.437456254342;5640.605157639008;5645.802396916089;5620.587838546803;5653.717314134359;5911.793087242012;5928.822135335947;5945.286565612154;5943.940560594425;5954.8809023819285;5968.910881191635;5978.641281523122;5982.312034116132;5628.4090170533145;5734.3978882218435;5822.214001109796;5843.7370318336625;5862.706864656665;5767.567432442667;5770.567207459541;5783.306003279633;5800.651960882361;5802.65184088956;5936.732847021808;5949.52403807703;5988.8802223956145;6006.87986240264;6038.396160383926;4000.6796058286704;4160.958390416178;4175.707700460938;4253.276942919773;4259.595338442843;5575.721213939368;5711.3431955324;5745.540356771365;5814;5815;5660.20757093999;5733.168690539932;5735.254416925773;5749.080147176432;5780.306363236438;5600.57995650336;5696.772129114789;5727.455891690282;5738.167965644875;5740.741666625096;5685.77256909719;5698.466950490722;5701.287339082614;5717.7141142941855;5729.828105156852;5687.1753595729215;5732.3121225453215;5733.082706766897;5751.4536119068625;5779.248697669276;5388.326459192601;5544.306961629796;5571.4121475379325;5588.217649529151;5604.047311957059 21:16:30 INFO - PROCESS | 14903 | |5;yui.html;704.4012589299097;725.58278989581;754.2495217258825;775.4223103787677;799.804048008238;15290.847091529082;15930.442434514795;15952.883298169147;15954.361825526994;16015.919920400396;13842.930785346085;13876.791848122286;13916;13932.51236206733;13934.51229206978;727.0330460487539;729.1651059536854;845.8054647431095;846.5724808971477;868.0191383736369;851.7231899632613;864.2524216552669;870.7605408512646;871.1375738019346;871.1767379826067;922.3912217936163;922.6632279218071;923.6628630549868;923.9630414783434;924.5654542365078;915.2815040193483;915.4964769376816;916.3493919317293;916.7387294621034;917.1424717888796;676.972921083156;677.6848765324098;679.1035832700837;679.8368391585984;680.6358598150016;14530.782038269434;15032.398704051935;15059.397624095023;15098.16960067196;15129.924350378287;13921.58235252934;14813.55559333211;14942.925285373612;15164.620884477867;15238.466653667068;10695.304805187716;10726.195535334804;10790.946045269802;10804.0816530595;10849.349039057683;3722.7021838252876;3744.8314825832904;3809.580946095927;3811.8284677189595;3818.5966856897458;64432;64822;66102.3389766101;66165.3383466164;66367.66816165937;10694.091002264739;10818.67543973682;10837.945810271056;10903.890961090288;10984.560617575207;19317.80682193188;19675.21299148047;19982.10080546379;20198;20253.49366265855;7615.885761713579;8054.114047454776;8166.346692264605;8241.175882411711;8376.036755773042;4454.532274111171;4464.888377790581;4539.228331183706;4641.791119399635;4651.09303685778;3295.6374798772117;3346.347462244839;3365.9495107573407;3387.542681737983;3413.965860341365;579.7536047179932;585.5988647776287;595.5027551994046;606.6572386601556;626.5582764151262;557.3896583241344;559.3735016781231;607.9694917115535;628.5286035473395;642.6979319719725;8112.594370281462;8881.37830351882;9085.68200113006;9395.483248421402;9434.433933963985;582.6911736779514;597.0742368924253;643.427349658804;649.2792999770252;652.3248437866785;4119;4175.937360939588;4282.507511636201;4318.30907054876;4416.867493975186;51420;59381;72339;83231;87260.12739872647;46622.53377466182;57881.710591446776;71101.2889871105;74458;75254.62372688102;67271.66364168246;68729.65635171892;70344;71755.64122179356;72431.99999999895;8390.454620449651;8417.83164336722;8581.442206256574;8592;8728.519931403835;43581.78209108934;44090.55909440864;45059.54940450554;45093.32360014537;47068.29397558971;59491.40508594859;63958.36041639524;65394.34605653882;65420.67289663521;65528.689426212164;10077.899221007989;10382.532786024798;10434.947825261128;10446.05985461312;11263.042641375574;11332.376719280519;11656.766864662828;11677.240979336317;11692.064634829363;11806.350650714294;10097.495125243855;10097.798044039226;10220.488975551341;10370.896291036994;12205.938970305091;12252.632421027383;12617.747645046864;12656.493740250287;12756.362181891054;12836.679083022998;11609;11834.58578949767;12022.639320820039;12550.560730374393;12681.048921331121;10335.17318614524;10358.896411035794;10483;10982.560697572007;11072.612458563912;10646.946765266433;10721.517531710935;10816.498526383195;11027.889721102687;11158.330500170016 21:16:30 INFO - PROCESS | 14903 | __end_tp_report 21:16:30 INFO - PROCESS | 14903 | __start_cc_report 21:16:30 INFO - PROCESS | 14903 | _x_x_mozilla_cycle_collect,947 21:16:30 INFO - PROCESS | 14903 | __end_cc_report 21:16:30 INFO - PROCESS | 14903 | __startTimestamp1486703790125__endTimestamp 21:16:30 INFO - PROCESS | 14903 | 21:16:30 INFO - PROCESS | 14903 | ------- Summary: start ------- 21:16:30 INFO - PROCESS | 14903 | Number of tests: 6 21:16:30 INFO - PROCESS | 14903 | 21:16:30 INFO - PROCESS | 14903 | [#0] dojo.html Cycles:165 Average:5536.04 Median:5699.23 stddev:620.91 (10.9%) stddev-sans-first:595.10 21:16:30 INFO - PROCESS | 14903 | Values: 3197.7 3226.5 3245.5 3257.3 3283.7 5525.9 5545.5 5570.5 5616.6 5635.9 5596.3 5656.7 5660.1 5668.3 5708.9 5057.6 5131.4 5166.4 5168.5 5213.0 4894.2 4910.9 5193.6 5214.3 5218.7 4995.4 5020.1 5048.5 5115.9 5162.5 5160.4 5177.1 5224.4 5233.6 5238.8 4832.1 4839.2 5086.1 5115.4 5169.3 5362.1 5404.1 5480.0 5495.2 5503.7 5925.5 5981.2 6018.3 6018.8 6031.7 5756.1 5808.5 6031.3 6054.1 6062.5 5504.4 5569.0 5569.2 5570.4 5591.5 6102.8 6108.3 6115.9 6127.4 6127.9 5668.9 5727.8 5858.4 5863.5 5875.3 5951.5 5993.0 6011.2 6018.3 6025.2 5954.5 5960.7 5967.0 5969.8 5970.1 5915.6 5976.0 5985.0 5991.4 6006.0 4464.4 4486.9 4552.4 4570.2 4580.0 4089.6 4092.5 4092.9 4097.6 4115.6 5637.2 5638.1 5639.0 5656.2 5686.7 5691.9 5741.4 5886.3 5934.4 5963.4 5617.4 5636.7 5637.5 5657.8 5671.5 5147.6 5155.8 5158.7 5161.6 5212.9 5922.6 5982.0 6057.8 6068.8 6130.5 6003.2 6078.2 6107.6 6118.2 6118.5 6173.3 6184.9 6190.5 6204.9 6211.3 5575.2 5930.2 5932.4 5941.5 5963.5 5791.6 5915.1 5926.3 5957.9 6047.2 5804.9 5837.9 5856.6 5861.5 5866.6 5803.9 5812.4 5841.0 5852.1 5862.1 5642.6 5699.2 5701.2 5706.9 5736.1 5811.1 5814.8 5818.0 5836.6 5845.1 5580.3 5620.6 5636.2 5690.1 5709.9 21:16:30 INFO - PROCESS | 14903 | 21:16:30 INFO - PROCESS | 14903 | [#1] ext.html Cycles:180 Average:59674.49 Median:36051.64 stddev:116728.70 (323.8%) stddev-sans-first:116971.83 21:16:30 INFO - PROCESS | 14903 | Values: 579.9 614.1 639.0 658.4 658.6 33694.0 45266.5 45268.5 45507.5 45521.8 45047.8 45507.0 45595.0 45619.8 45638.8 8362.6 9061.6 9206.6 9217.8 9221.1 8476.8 10712.1 11107.0 11108.7 11383.9 11214.6 11259.8 11281.3 11294.3 11346.6 11016.6 11061.8 11064.7 11071.4 11071.9 10984.7 11101.3 11103.6 11103.9 11114.9 43532.0 43812.6 43851.3 43870.8 43899.0 3330.1 3392.3 3447.3 3524.6 3871.5 32019.7 32407.8 32426.0 32576.2 33003.0 3440.5 3502.0 3534.5 3554.7 3612.5 331384.0 334554.0 335895.0 336966.0 337279.0 61601.4 61911.7 61942.4 61965.7 62036.0 35286.0 35950.5 36024.3 36079.0 36122.5 18867.4 19064.0 19081.2 19087.8 19094.9 13490.0 13703.9 14611.1 14700.7 14753.0 19553.6 20195.4 20495.7 20507.0 20550.8 7587.1 7632.5 7682.8 7766.9 7772.4 867.6 876.8 907.9 1019.9 1034.8 29527.9 30304.8 30322.8 30333.7 31443.0 1023.9 1042.0 1046.3 1087.9 1106.5 15310.8 15983.4 16128.0 16169.1 16395.8 530213.3 536059.0 536119.0 536668.0 536706.0 60418.1 60884.0 61035.7 61175.4 61196.0 1308.8 1353.8 1397.8 1401.7 1430.0 28782.0 31104.4 31371.8 32235.0 32591.7 51242.0 56609.4 57792.1 58246.4 64408.0 425692.0 428542.0 430265.0 430511.0 430633.0 35928.6 36515.5 39235.8 40630.0 42265.6 44822.8 44968.6 44971.0 45064.5 45165.0 39117.2 39118.0 39178.6 39399.8 40157.4 38010.0 38289.2 39645.6 39780.2 39890.0 38593.2 39010.4 39393.2 39734.4 39860.0 33440.5 35459.6 36124.5 36207.1 36438.8 27173.3 27445.0 27482.5 27495.7 27500.7 21:16:30 INFO - PROCESS | 14903 | 21:16:30 INFO - PROCESS | 14903 | [#2] jquery.html Cycles:180 Average:27394.57 Median:216162.82 stddev:74890.12 (34.6%) stddev-sans-first:75072.83 21:16:30 INFO - PROCESS | 14903 | Values: 424.5 426.9 428.6 432.3 434.3 18077.7 18430.2 19158.2 19398.0 19438.9 18951.5 19132.2 19148.8 19209.8 19643.9 5509.2 5894.6 5932.4 5933.8 5938.4 5763.2 5809.8 5930.8 5951.2 5957.2 6046.1 6101.5 6119.1 6123.8 6125.1 5826.6 5998.2 6039.2 6045.9 6102.5 5855.9 5882.4 5891.6 5893.5 5893.6 13904.4 14177.7 14274.4 14275.7 14323.5 2246.3 2321.0 2323.4 2334.6 2444.2 10457.9 10627.8 10650.4 10694.1 10929.6 1812.2 1947.9 1971.4 2051.2 2079.7 79104.0 81059.6 81777.6 82467.6 82991.6 11054.6 11108.7 11192.6 11212.2 11551.2 16093.5 16099.9 16122.0 16131.9 16132.1 8569.6 8650.3 8713.6 8809.9 8837.2 8392.8 8395.5 8579.4 8628.2 8635.4 4864.4 4914.4 4939.7 4966.7 5070.4 2045.4 2075.1 2104.3 2105.8 2111.8 939.3 957.9 966.1 972.7 989.0 17525.4 18319.1 18399.6 18464.0 18596.4 911.6 938.8 960.1 970.5 983.8 9611.8 10044.5 10336.1 10350.0 10352.8 431897.0 438670.0 463563.0 464488.0 465307.0 88097.0 88474.0 88505.0 89264.0 90994.0 983.5 1025.8 1026.8 1027.7 1034.7 14503.9 15601.2 15730.0 15732.8 16105.0 37858.2 42467.0 43686.6 44884.8 44921.0 47971.0 55892.0 55976.0 56031.0 57061.7 7676.5 7990.7 8068.3 8098.5 8174.1 10152.8 11466.5 11828.6 12040.6 12088.5 10399.2 10466.1 10549.7 10702.4 10762.8 9797.7 9800.7 10137.5 10335.6 10557.9 10547.8 10656.3 10739.5 10932.8 10961.9 7686.9 7908.3 7942.7 7955.4 7997.5 10556.6 10640.4 10673.0 10715.1 10985.8 21:16:30 INFO - PROCESS | 14903 | 21:16:30 INFO - PROCESS | 14903 | [#3] mootools.html Cycles:180 Average:5820.85 Median:4706.29 stddev:3366.84 (71.5%) stddev-sans-first:3359.40 21:16:30 INFO - PROCESS | 14903 | Values: 1333.4 1504.4 1522.8 1645.7 1808.9 7873.5 8603.4 8894.0 8899.6 9193.6 9058.1 9123.5 9125.1 9131.3 9135.7 2472.4 2499.0 2502.2 2502.9 2506.0 2463.0 2511.4 2511.4 2513.9 2516.4 2452.4 2456.2 2464.6 2464.8 2467.1 2401.9 2408.0 2425.1 2432.1 2432.8 2411.4 2434.5 2452.9 2454.9 2456.2 8723.9 8907.7 9089.6 9091.6 9099.4 5451.1 5675.7 5679.7 5682.0 5688.7 3392.1 3523.7 3581.4 3634.0 3659.3 1074.0 1105.9 1112.7 1134.8 1156.5 12266.8 12527.6 12535.0 12573.3 12605.5 4427.8 4655.7 4689.1 4723.5 4758.3 10005.1 10009.6 10012.6 10020.2 10022.9 5487.8 5490.7 5493.3 5493.9 5494.8 4457.0 4551.6 5132.7 5157.9 5180.7 4131.1 4144.9 4209.6 4240.4 4242.9 1270.6 1301.6 1309.4 1311.6 1326.5 679.6 776.4 781.5 783.5 792.2 5461.5 5567.5 5628.3 5633.2 5679.7 459.4 474.8 480.2 481.1 482.9 3681.3 3685.8 3702.7 3706.2 3731.6 10859.9 11271.2 11356.8 11431.6 11435.1 11309.0 11327.5 11330.4 11331.8 11335.3 8437.8 8511.6 8584.6 8652.9 8653.3 5522.1 5599.8 5675.4 5691.0 5715.4 10221.4 10328.6 10331.8 10500.4 10513.4 10687.9 10688.0 10780.6 10780.7 10793.1 6674.8 6836.4 6839.8 7355.8 7449.3 7666.3 8180.1 8223.5 8438.2 8441.4 7414.0 7432.4 7534.8 7554.9 7648.7 7571.5 7582.0 7604.3 7658.0 7682.0 6582.7 6730.8 6739.5 6742.0 6742.9 4951.8 4996.3 5032.7 5040.1 5199.9 4832.0 4883.6 4897.0 5006.9 5065.6 21:16:30 INFO - PROCESS | 14903 | 21:16:30 INFO - PROCESS | 14903 | [#4] prototype.html Cycles:180 Average:4753.56 Median:5392.01 stddev:1382.59 (25.6%) stddev-sans-first:1346.10 21:16:30 INFO - PROCESS | 14903 | Values: 334.2 343.6 351.7 353.9 357.1 5411.9 5451.5 5460.0 5460.2 5475.9 5138.0 5214.9 5234.5 5331.6 5395.7 4212.2 4246.6 4261.2 4264.3 4270.6 4265.6 4267.5 4281.8 4282.4 4286.6 4125.3 4231.6 4241.2 4252.4 4269.8 4228.7 4233.0 4242.4 4255.2 4263.2 3808.4 3808.4 3810.5 3825.8 3828.6 5019.5 5228.3 5245.9 5254.5 5281.3 4865.9 4872.4 4881.6 4890.9 4891.5 5602.2 5652.3 5655.5 5659.9 5666.5 4030.3 4094.7 4133.4 4136.2 4149.4 5811.6 5825.5 5832.6 5836.1 5841.4 4195.8 4206.7 4207.4 4211.2 4225.2 4159.7 4247.1 4303.1 4304.6 4306.8 4827.4 4838.4 4840.2 4875.8 4883.1 5628.7 5649.0 5719.5 5734.6 5735.5 1407.7 1413.0 1413.1 1421.0 1425.0 977.9 982.9 986.0 988.3 1005.2 5170.9 5183.2 5191.3 5208.2 5210.8 5517.8 5543.0 5567.9 5576.6 5596.1 5013.0 5212.7 5227.0 5255.9 5260.6 2928.8 2939.6 2939.9 2947.4 2952.2 5597.7 5618.4 5625.4 5640.6 5645.8 5620.6 5653.7 5911.8 5928.8 5945.3 5943.9 5954.9 5968.9 5978.6 5982.3 5628.4 5734.4 5822.2 5843.7 5862.7 5767.6 5770.6 5783.3 5800.7 5802.7 5936.7 5949.5 5988.9 6006.9 6038.4 4000.7 4161.0 4175.7 4253.3 4259.6 5575.7 5711.3 5745.5 5814.0 5815.0 5660.2 5733.2 5735.3 5749.1 5780.3 5600.6 5696.8 5727.5 5738.2 5740.7 5685.8 5698.5 5701.3 5717.7 5729.8 5687.2 5732.3 5733.1 5751.5 5779.2 5388.3 5544.3 5571.4 5588.2 5604.0 21:16:30 INFO - PROCESS | 14903 | 21:16:30 INFO - PROCESS | 14903 | [#5] yui.html Cycles:180 Average:16911.22 Median:24816.28 stddev:21979.48 (88.6%) stddev-sans-first:22007.45 21:16:30 INFO - PROCESS | 14903 | Values: 704.4 725.6 754.2 775.4 799.8 15290.8 15930.4 15952.9 15954.4 16015.9 13842.9 13876.8 13916.0 13932.5 13934.5 727.0 729.2 845.8 846.6 868.0 851.7 864.3 870.8 871.1 871.2 922.4 922.7 923.7 924.0 924.6 915.3 915.5 916.3 916.7 917.1 677.0 677.7 679.1 679.8 680.6 14530.8 15032.4 15059.4 15098.2 15129.9 13921.6 14813.6 14942.9 15164.6 15238.5 10695.3 10726.2 10790.9 10804.1 10849.3 3722.7 3744.8 3809.6 3811.8 3818.6 64432.0 64822.0 66102.3 66165.3 66367.7 10694.1 10818.7 10837.9 10903.9 10984.6 19317.8 19675.2 19982.1 20198.0 20253.5 7615.9 8054.1 8166.3 8241.2 8376.0 4454.5 4464.9 4539.2 4641.8 4651.1 3295.6 3346.3 3365.9 3387.5 3414.0 579.8 585.6 595.5 606.7 626.6 557.4 559.4 608.0 628.5 642.7 8112.6 8881.4 9085.7 9395.5 9434.4 582.7 597.1 643.4 649.3 652.3 4119.0 4175.9 4282.5 4318.3 4416.9 51420.0 59381.0 72339.0 83231.0 87260.1 46622.5 57881.7 71101.3 74458.0 75254.6 67271.7 68729.7 70344.0 71755.6 72432.0 8390.5 8417.8 8581.4 8592.0 8728.5 43581.8 44090.6 45059.5 45093.3 47068.3 59491.4 63958.4 65394.3 65420.7 65528.7 10077.9 10382.5 10434.9 10446.1 11263.0 11332.4 11656.8 11677.2 11692.1 11806.4 10097.5 10097.8 10220.5 10370.9 12205.9 12252.6 12617.7 12656.5 12756.4 12836.7 11609.0 11834.6 12022.6 12550.6 12681.0 10335.2 10358.9 10483.0 10982.6 11072.6 10646.9 10721.5 10816.5 11027.9 11158.3 21:16:30 INFO - PROCESS | 14903 | -------- Summary: end -------- 21:16:30 INFO - PROCESS | 14903 | 21:16:30 INFO - TEST-INFO | 14903: exit 0 21:16:30 INFO - TEST-OK | dromaeo_css | took 1114566ms 21:16:30 INFO - TEST-START | kraken 21:16:30 INFO - operating with platform_type : linux_ 21:16:30 INFO - Initialising browser for kraken test... 21:16:30 INFO - TEST-INFO | started process 15209 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCtRDiJ/profile http://localhost:40552/getInfo.html) 21:16:34 INFO - PROCESS | 15209 | __metrics Screen width/height:1600/1200 21:16:34 INFO - PROCESS | 15209 | colorDepth:24 21:16:34 INFO - PROCESS | 15209 | Browser inner width/height: 1024/697 21:16:34 INFO - PROCESS | 15209 | __metrics 21:16:35 INFO - PROCESS | 15209 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:16:35 INFO - PROCESS | 15209 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:16:35 INFO - PROCESS | 15209 | console.error: PushService: 21:16:35 INFO - PROCESS | 15209 | stateChangeProcessEnqueue: Error transitioning state 21:16:35 INFO - PROCESS | 15209 | UnknownError 21:16:36 INFO - TEST-INFO | 15209: exit 0 21:16:36 INFO - Browser initialized. 21:16:36 INFO - Running cycle 1/1 for kraken test... 21:16:36 INFO - TEST-INFO | started process 15301 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCtRDiJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:16:47 INFO - PROCESS | 15301 | RSS: Main: 141819904 21:16:47 INFO - PROCESS | 15301 | 21:16:50 INFO - PROCESS | 15301 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40552/tests/kraken/driver.html?testName=audio-beat-detection) 21:16:51 INFO - PROCESS | 15301 | RSS: Main: 183508992 21:16:51 INFO - PROCESS | 15301 | 21:16:53 INFO - PROCESS | 15301 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40552/tests/kraken/driver.html?testName=audio-dft) 21:16:54 INFO - PROCESS | 15301 | RSS: Main: 173309952 21:16:54 INFO - PROCESS | 15301 | 21:16:57 INFO - PROCESS | 15301 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40552/tests/kraken/driver.html?testName=audio-fft) 21:16:57 INFO - PROCESS | 15301 | RSS: Main: 264314880 21:16:57 INFO - PROCESS | 15301 | 21:16:59 INFO - PROCESS | 15301 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40552/tests/kraken/driver.html?testName=audio-oscillator) 21:17:00 INFO - PROCESS | 15301 | RSS: Main: 171450368 21:17:00 INFO - PROCESS | 15301 | 21:17:02 INFO - PROCESS | 15301 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40552/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:17:03 INFO - PROCESS | 15301 | RSS: Main: 173264896 21:17:03 INFO - PROCESS | 15301 | 21:17:06 INFO - PROCESS | 15301 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40552/tests/kraken/driver.html?testName=imaging-darkroom) 21:17:06 INFO - PROCESS | 15301 | RSS: Main: 211996672 21:17:06 INFO - PROCESS | 15301 | 21:17:10 INFO - PROCESS | 15301 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40552/tests/kraken/driver.html?testName=imaging-desaturate) 21:17:10 INFO - PROCESS | 15301 | RSS: Main: 210862080 21:17:10 INFO - PROCESS | 15301 | 21:17:13 INFO - PROCESS | 15301 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40552/tests/kraken/driver.html?testName=json-parse-financial) 21:17:13 INFO - PROCESS | 15301 | RSS: Main: 209620992 21:17:13 INFO - PROCESS | 15301 | 21:17:15 INFO - PROCESS | 15301 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40552/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:17:15 INFO - PROCESS | 15301 | RSS: Main: 172126208 21:17:15 INFO - PROCESS | 15301 | 21:17:17 INFO - PROCESS | 15301 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40552/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:17:18 INFO - PROCESS | 15301 | RSS: Main: 178761728 21:17:18 INFO - PROCESS | 15301 | 21:17:20 INFO - PROCESS | 15301 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40552/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:17:20 INFO - PROCESS | 15301 | RSS: Main: 188641280 21:17:20 INFO - PROCESS | 15301 | 21:17:23 INFO - PROCESS | 15301 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40552/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:17:24 INFO - PROCESS | 15301 | RSS: Main: 196362240 21:17:24 INFO - PROCESS | 15301 | 21:17:26 INFO - PROCESS | 15301 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40552/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:17:27 INFO - PROCESS | 15301 | RSS: Main: 193196032 21:17:27 INFO - PROCESS | 15301 | 21:17:28 INFO - PROCESS | 15301 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40552/tests/kraken/driver.html?testName=ai-astar) 21:17:29 INFO - PROCESS | 15301 | RSS: Main: 245268480 21:17:29 INFO - PROCESS | 15301 | 21:17:29 INFO - PROCESS | 15301 | __start_tp_report 21:17:29 INFO - PROCESS | 15301 | _x_x_mozilla_page_load 21:17:29 INFO - PROCESS | 15301 | _x_x_mozilla_page_load_details 21:17:29 INFO - PROCESS | 15301 | |i|pagename|runs| 21:17:29 INFO - PROCESS | 15301 | |0;ai-astar;102;109;112;110;110;110;109;109;110;111 21:17:29 INFO - PROCESS | 15301 | |1;audio-beat-detection;156;118;118;161;122;123;117;117;141;116 21:17:29 INFO - PROCESS | 15301 | |2;audio-dft;159;161;160;162;160;161;160;160;160;160 21:17:29 INFO - PROCESS | 15301 | |3;audio-fft;74;77;76;101;75;76;74;74;96;74 21:17:29 INFO - PROCESS | 15301 | |4;audio-oscillator;83;81;131;81;81;82;97;82;81;109 21:17:29 INFO - PROCESS | 15301 | |5;imaging-gaussian-blur;116;117;116;117;118;117;117;117;118;118 21:17:29 INFO - PROCESS | 15301 | |6;imaging-darkroom;146;145;146;146;147;147;147;148;146;146 21:17:29 INFO - PROCESS | 15301 | |7;imaging-desaturate;85;84;84;84;84;85;84;87;85;84 21:17:29 INFO - PROCESS | 15301 | |8;json-parse-financial;52;51;51;50;52;51;52;52;51;51 21:17:29 INFO - PROCESS | 15301 | |9;json-stringify-tinderbox;61;61;60;60;63;61;60;61;60;60 21:17:29 INFO - PROCESS | 15301 | |10;stanford-crypto-aes;74;74;75;78;84;80;75;74;75;74 21:17:29 INFO - PROCESS | 15301 | |11;stanford-crypto-ccm;125;123;124;128;132;120;121;130;158;124 21:17:29 INFO - PROCESS | 15301 | |12;stanford-crypto-pbkdf2;164;162;162;161;163;158;163;160;160;159 21:17:29 INFO - PROCESS | 15301 | |13;stanford-crypto-sha256-iterative;63;64;64;63;62;65;64;64;62;62 21:17:29 INFO - PROCESS | 15301 | __end_tp_report 21:17:29 INFO - PROCESS | 15301 | __start_cc_report 21:17:29 INFO - PROCESS | 15301 | _x_x_mozilla_cycle_collect,1521 21:17:29 INFO - PROCESS | 15301 | __end_cc_report 21:17:29 INFO - PROCESS | 15301 | __startTimestamp1486703849241__endTimestamp 21:17:29 INFO - PROCESS | 15301 | 21:17:29 INFO - PROCESS | 15301 | ------- Summary: start ------- 21:17:29 INFO - PROCESS | 15301 | Number of tests: 14 21:17:29 INFO - PROCESS | 15301 | 21:17:29 INFO - PROCESS | 15301 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:2.70 (2.5%) stddev-sans-first:1.00 21:17:29 INFO - PROCESS | 15301 | Values: 102.0 109.0 112.0 110.0 110.0 110.0 109.0 109.0 110.0 111.0 21:17:29 INFO - PROCESS | 15301 | 21:17:29 INFO - PROCESS | 15301 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:122.50 stddev:17.26 (14.1%) stddev-sans-first:15.27 21:17:29 INFO - PROCESS | 15301 | Values: 156.0 118.0 118.0 161.0 122.0 123.0 117.0 117.0 141.0 116.0 21:17:29 INFO - PROCESS | 15301 | 21:17:29 INFO - PROCESS | 15301 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.73 21:17:29 INFO - PROCESS | 15301 | Values: 159.0 161.0 160.0 162.0 160.0 161.0 160.0 160.0 160.0 160.0 21:17:29 INFO - PROCESS | 15301 | 21:17:29 INFO - PROCESS | 15301 | [#3] audio-fft Cycles:10 Average:79.70 Median:75.50 stddev:10.03 (13.3%) stddev-sans-first:10.43 21:17:29 INFO - PROCESS | 15301 | Values: 74.0 77.0 76.0 101.0 75.0 76.0 74.0 74.0 96.0 74.0 21:17:29 INFO - PROCESS | 15301 | 21:17:29 INFO - PROCESS | 15301 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:81.50 stddev:16.95 (20.8%) stddev-sans-first:17.74 21:17:29 INFO - PROCESS | 15301 | Values: 83.0 81.0 131.0 81.0 81.0 82.0 97.0 82.0 81.0 109.0 21:17:29 INFO - PROCESS | 15301 | 21:17:29 INFO - PROCESS | 15301 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 21:17:29 INFO - PROCESS | 15301 | Values: 116.0 117.0 116.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 21:17:29 INFO - PROCESS | 15301 | 21:17:29 INFO - PROCESS | 15301 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 21:17:29 INFO - PROCESS | 15301 | Values: 146.0 145.0 146.0 146.0 147.0 147.0 147.0 148.0 146.0 146.0 21:17:29 INFO - PROCESS | 15301 | 21:17:29 INFO - PROCESS | 15301 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:84.50 stddev:0.97 (1.1%) stddev-sans-first:1.01 21:17:29 INFO - PROCESS | 15301 | Values: 85.0 84.0 84.0 84.0 84.0 85.0 84.0 87.0 85.0 84.0 21:17:29 INFO - PROCESS | 15301 | 21:17:29 INFO - PROCESS | 15301 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.50 stddev:0.67 (1.3%) stddev-sans-first:0.67 21:17:29 INFO - PROCESS | 15301 | Values: 52.0 51.0 51.0 50.0 52.0 51.0 52.0 52.0 51.0 51.0 21:17:29 INFO - PROCESS | 15301 | 21:17:29 INFO - PROCESS | 15301 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.95 (1.6%) stddev-sans-first:1.00 21:17:29 INFO - PROCESS | 15301 | Values: 61.0 61.0 60.0 60.0 63.0 61.0 60.0 61.0 60.0 60.0 21:17:29 INFO - PROCESS | 15301 | 21:17:29 INFO - PROCESS | 15301 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:75.00 stddev:3.37 (4.5%) stddev-sans-first:3.47 21:17:29 INFO - PROCESS | 15301 | Values: 74.0 74.0 75.0 78.0 84.0 80.0 75.0 74.0 75.0 74.0 21:17:29 INFO - PROCESS | 15301 | 21:17:29 INFO - PROCESS | 15301 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:126.50 stddev:11.04 (8.7%) stddev-sans-first:11.63 21:17:29 INFO - PROCESS | 15301 | Values: 125.0 123.0 124.0 128.0 132.0 120.0 121.0 130.0 158.0 124.0 21:17:29 INFO - PROCESS | 15301 | 21:17:29 INFO - PROCESS | 15301 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:162.00 stddev:1.93 (1.2%) stddev-sans-first:1.76 21:17:29 INFO - PROCESS | 15301 | Values: 164.0 162.0 162.0 161.0 163.0 158.0 163.0 160.0 160.0 159.0 21:17:29 INFO - PROCESS | 15301 | 21:17:29 INFO - PROCESS | 15301 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:64.00 stddev:1.06 (1.7%) stddev-sans-first:1.12 21:17:29 INFO - PROCESS | 15301 | Values: 63.0 64.0 64.0 63.0 62.0 65.0 64.0 64.0 62.0 62.0 21:17:29 INFO - PROCESS | 15301 | -------- Summary: end -------- 21:17:29 INFO - PROCESS | 15301 | 21:17:30 INFO - TEST-INFO | 15301: exit 0 21:17:30 INFO - TEST-OK | kraken | took 59361ms 21:17:30 INFO - SUITE-END | took 1173s 21:17:30 INFO - Completed test suite (00:19:34) 21:17:30 INFO - javascript benchmark 21:17:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3197.744180465563, 3226.4998925166606, 3245.4807230843053, 3257.348530293941, 3283.720883724884, 5525.944740552603, 5545.528630066444, 5570.526505247049, 5616.606837521375, 5635.887282254353, 5596.300462442195, 5656.745446454909, 5660.066089095294, 5668.319801623811, 5708.914366284509, 5057.595392368602, 5131.358580177478, 5166.380034395859, 5168.508991645806, 5213.0, 4894.1679914414635, 4910.852674419773, 5193.558547523465, 5214.322138122057, 5218.686878787266, 4995.400551933773, 5020.146575082244, 5048.545630893219, 5115.897682046357, 5162.483751624845, 5160.354955630546, 5177.119889618773, 5224.39919409269, 5233.5551478124025, 5238.842834714965, 4832.081904438145, 4839.225723884161, 5086.084504789136, 5115.437301896788, 5169.302144210521, 5362.061639213122, 5404.081306177959, 5479.972600136974, 5495.175723641486, 5503.724813759296, 5925.525957923356, 5981.162637230791, 6018.307894592134, 6018.819435416901, 6031.698415079229, 5756.136579513065, 5808.506276966463, 6031.276246850406, 6054.091886217058, 6062.514998800129, 5504.366997795225, 5568.972155139199, 5569.164625306236, 5570.387257401682, 5591.4688104629995, 6102.847428814315, 6108.3280839107665, 6115.877682446326, 6127.4485296322655, 6127.938720612826, 5668.943310566841, 5727.77088916447, 5858.384869588632, 5863.472287494146, 5875.265591801025, 5951.464368206795, 5993.0, 6011.1884895539415, 6018.277806663141, 6025.216721826135, 5954.523638108941, 5960.7019649017375, 5967.0, 5969.79105731306, 5970.104484327386, 5915.585908986416, 5975.970120149372, 5984.970075149597, 5991.430814072656, 6006.039033754579, 4464.441944756905, 4486.910261794746, 4552.430946131733, 4570.154521413549, 4579.977100114545, 4089.5900437778264, 4092.46797916269, 4092.897677558085, 4097.590240975938, 4115.588441155861, 5637.23897273871, 5638.126090455986, 5639.0, 5656.208130861683, 5686.744096515667, 5691.8861622768145, 5741.368449470555, 5886.293644762571, 5934.43622855828, 5963.4334738199805, 5617.43825617435, 5636.689982051026, 5637.46444087811, 5657.773689052474, 5671.546276297886, 5147.6396652234735, 5155.767990440364, 5158.690478571298, 5161.561267292323, 5212.947870521322, 5922.555808314308, 5982.0, 6057.757689692539, 6068.787592434332, 6130.509559235251, 6003.219581454558, 6078.240219972504, 6107.572469927062, 6118.174046503665, 6118.479929206067, 6173.290071641639, 6184.856834791036, 6190.473809726223, 6204.906926396017, 6211.254649442096, 5575.2473416088305, 5930.199423077829, 5932.436418540232, 5941.494972927349, 5963.522918166623, 5791.623544469596, 5915.142304365757, 5926.318473375444, 5957.91063134062, 6047.183630209865, 5804.854878627899, 5837.883242335214, 5856.59003869725, 5861.472467477947, 5866.5893387464175, 5803.8549036274435, 5812.418758124154, 5840.970795145997, 5852.122181672783, 5862.12068189775, 5642.633228840113, 5699.230603868425, 5701.201831743642, 5706.914396284142, 5736.053551164178, 5811.099279611667, 5814.76740930358, 5818.0, 5836.620619659709, 5845.09401042839, 5580.274564306615, 5620.578456615688, 5636.239107720569, 5690.089585666274, 5709.857253568528], "value": 5494.799543721338, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.8637320229745, 614.0911451052442, 638.9616623002619, 658.4173006888902, 658.5850913924227, 33694.0, 45266.547334526644, 45268.54731452685, 45507.54492455075, 45521.77239113808, 45047.77476112623, 45507.0, 45595.0, 45619.77190114045, 45638.771806141005, 8362.58187090646, 9061.637534498628, 9206.585703643352, 9217.769555761126, 9221.077892210793, 8476.78808029798, 10712.089472394817, 11107.000369966701, 11108.666739997812, 11383.94308028463, 11214.607488737896, 11259.831102533468, 11281.266717663366, 11294.265872718248, 11346.60286889959, 11016.614418495354, 11061.778764424747, 11064.668059958214, 11071.446427678664, 11071.889281107166, 10984.670459886216, 11101.333919964827, 11103.611373601885, 11103.944480277547, 11114.888851111466, 43532.0, 43812.561874381485, 43851.342229866576, 43870.780646096566, 43899.0, 3330.134165117063, 3392.3045775615938, 3447.3105378924065, 3524.559430071241, 3871.5354157500997, 32019.679803202136, 32407.83796081028, 32426.0, 32576.185595360068, 33003.00990970275, 3440.535527703753, 3502.0, 3534.469829525566, 3554.697850682695, 3612.5303710517464, 331384.0, 334554.0, 335895.0, 336966.0, 337279.0, 61601.38398615956, 61911.6904415484, 61942.38057619366, 61965.69017154886, 62036.0, 35286.0, 35950.46074308887, 36024.27951441009, 36079.0, 36122.45816312757, 18867.43397698044, 19064.0, 19081.2367505301, 19087.809121908882, 19094.904525477283, 13490.0, 13703.862961370258, 14611.123332600078, 14700.705985880437, 14753.0, 19553.63024773948, 20195.394138175583, 20495.69256461154, 20507.0, 20550.794492054887, 7587.127480339721, 7632.537716618225, 7682.769516914502, 7766.88349674744, 7772.378209743207, 867.5922316511229, 876.7545087375545, 907.9046700096527, 1019.8929112443235, 1034.7878684869584, 29527.85236073849, 30304.84847575792, 30322.84838575837, 30333.69666303353, 31443.0, 1023.9078482936571, 1041.963246569668, 1046.26238501856, 1087.9401632910108, 1106.4523061084653, 15310.846891530942, 15983.44057957966, 16128.002871987259, 16169.110698911672, 16395.83604163943, 530213.3489332605, 536059.0, 536119.0, 536668.0, 536706.0, 60418.0937285941, 60884.0, 61035.694821525605, 61175.38824611786, 61196.0, 1308.770965081126, 1353.824002879639, 1397.7903314502703, 1401.7126489069717, 1429.9642508937152, 28782.0, 31104.377912442076, 31371.84314078415, 32235.0, 32591.674083258862, 51242.0, 56609.43390566207, 57792.13311800242, 58246.41753582579, 64408.0, 425692.0, 428542.0, 430265.0, 430511.0, 430633.0, 35928.64071359253, 36515.53937842457, 39235.803820981855, 40630.0, 42265.57734422616, 44822.77588612036, 44968.55031449644, 44971.0, 45064.54935450735, 45165.0, 39117.217655646156, 39118.0, 39178.60821391863, 39399.80300098596, 40157.397639034854, 38010.0, 38289.23421531609, 39645.60354396534, 39780.20439591134, 39890.0, 38593.2281354377, 39010.41484377794, 39393.2121357577, 39734.40398394084, 39860.0, 33440.498392523645, 35459.64540354563, 36124.4581331275, 36207.094822629646, 36438.8178059108, 27173.320666983484, 27445.0, 27482.45035099327, 27495.725042750117, 27500.724992750616], "value": 20466.96306459322, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.4927311862324, 426.8740721487161, 428.63780105810577, 432.30183254044726, 434.31595237500943, 18077.728834067482, 18430.17064232111, 19158.233670653193, 19398.0, 19438.902805485952, 18951.526211844677, 19132.23471061156, 19148.80851191488, 19209.807901920976, 19643.901780491076, 5509.201165830962, 5894.646321220741, 5932.436418540232, 5933.821985340447, 5938.376470470603, 5763.164341170528, 5809.825705228829, 5930.792422265222, 5951.166836642873, 5957.225560677106, 6046.123312119762, 6101.511879049665, 6119.143319935212, 6123.785667501638, 6125.142480052797, 5826.563007774392, 5998.190244317005, 6039.184710064129, 6045.879082418371, 6102.481289090432, 5855.853603659943, 5882.3823498532465, 5891.646501209942, 5893.528517718572, 5893.58744887858, 13904.374303156383, 14177.716445671029, 14274.429022839075, 14275.714485710332, 14323.498677546237, 2246.269962262255, 2320.953580928389, 2323.4191452136965, 2334.556434277482, 2444.2422848916717, 10457.895421045845, 10627.84058239127, 10650.4142272175, 10694.144468442506, 10929.617463388744, 1812.2298023340159, 1947.8928658923896, 1971.428285797117, 2051.2205361962506, 2079.6672532394896, 79104.0, 81059.5947020267, 81777.59111204406, 82467.58766206191, 82991.585042075, 11054.557817687364, 11108.722281943015, 11192.552297908156, 11212.159088068427, 11551.191416600925, 16093.517194484184, 16099.919500402657, 16122.0, 16131.919340403223, 16132.112733799519, 8569.571521423904, 8650.264727498234, 8713.607887645072, 8809.867851982226, 8837.20465158126, 8392.79018024542, 8395.454295470774, 8579.356548258906, 8628.22345988864, 8635.395522313504, 4864.391951006124, 4914.36113305268, 4939.728314942641, 4966.652334336634, 5070.442251352349, 2045.3557129504159, 2075.1284460526617, 2104.2950611544998, 2105.77889321619, 2111.7571479279773, 939.3424602778083, 957.9377340472847, 966.0773960867355, 972.6547075788135, 988.9950550247347, 17525.386611468537, 18319.084045797656, 18399.632007359778, 18464.0, 18596.44210673682, 911.562450023979, 938.7981583959481, 960.1478985582861, 970.4710932541782, 983.8130755156498, 9611.759706007406, 10044.497775111215, 10336.121429678411, 10350.0, 10352.844707329396, 431897.0, 438670.0, 463563.0, 464488.0, 465307.0, 88097.0, 88474.0, 88505.0, 89264.0, 90994.0, 983.4738414947968, 1025.7538190834146, 1026.8049070676548, 1027.732789474727, 1034.6585626743308, 14503.92748036253, 15601.219939003231, 15730.0, 15732.764008539652, 16105.0, 37858.24283514369, 42467.0, 43686.56313436952, 44884.77557612191, 44921.0, 47971.0, 55892.0, 55976.0, 56031.0, 57061.71469142628, 7676.501027433199, 7990.720324788605, 8068.273855353046, 8098.473599216032, 8174.059983102019, 10152.847707284249, 11466.541338346373, 11828.645140645795, 12040.578579749666, 12088.516459341528, 10399.220058495794, 10466.110380617733, 10549.736256593647, 10702.357858528514, 10762.838557421488, 9797.657082002095, 9800.65697700577, 10137.493125343555, 10335.638252661121, 10557.9472102639, 10547.78904421892, 10656.307340022873, 10739.516721747385, 10932.836007459735, 10961.945190273998, 7686.884696729442, 7908.288254057163, 7942.682292708227, 7955.443118981616, 7997.520148791091, 10556.577736890438, 10640.414777187329, 10673.0, 10715.089217416607, 10985.780284394426], "value": 8981.657386272671, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.4199623163931, 1504.3982407037183, 1522.7715842623606, 1645.7366821308592, 1808.91859866306, 7873.527588344703, 8603.354748393873, 8894.021657617657, 8899.644014239431, 9193.58628861701, 9058.139476749715, 9123.54382280885, 9125.133112354315, 9131.269498440126, 9135.725928222148, 2472.3819045238693, 2499.0253801017616, 2502.1617758051075, 2502.8998840046374, 2506.0351764570682, 2462.9876850615724, 2511.4223728542447, 2511.4474815540643, 2513.924582262535, 2516.421223118675, 2452.4236804350962, 2456.1649039326626, 2464.581021226387, 2464.7658472445087, 2467.062516243825, 2401.9159329423474, 2407.9518409631796, 2425.0784701813373, 2432.0879670123704, 2432.7688869557364, 2411.44536756547, 2434.464417828093, 2452.8773561321864, 2454.864982425966, 2456.2017344362976, 8723.869141962876, 8907.688230911952, 9089.63641454341, 9091.63633454661, 9099.408538444979, 5451.127819548853, 5675.6878371689545, 5679.659220446745, 5681.971590142023, 5688.715564221772, 3392.08413728292, 3523.700485458739, 3581.3553560359123, 3634.018814919983, 3659.2864391443677, 1073.9677809665645, 1105.9447027648666, 1112.7329440934197, 1134.7730453909169, 1156.5316047000895, 12266.81599776004, 12527.624171274876, 12535.0, 12573.302604148506, 12605.495780168781, 4427.800748966304, 4655.650826188049, 4689.109069276895, 4723.48041715411, 4758.3100450434495, 10005.099541041342, 10009.599616015277, 10012.599496020222, 10020.198384129399, 10022.949885250528, 5487.780488780484, 5490.670559766347, 5493.258410114663, 5493.917591236134, 5494.835154945358, 4456.977715111404, 4551.613112885376, 5132.717700526507, 5157.871053223699, 5180.663256888291, 4131.0679611650485, 4144.937825932613, 4209.642180414699, 4240.363945408213, 4242.915141697149, 1270.5616562285998, 1301.5639760680278, 1309.4107651556837, 1311.6196303072002, 1326.5423428917202, 679.6363945289246, 776.4099284543787, 781.4998401023349, 783.4554984285867, 792.180093603118, 5461.481159289861, 5567.498925096761, 5628.296462942132, 5633.211350410946, 5679.6876171810945, 459.4165409929438, 474.8005837548238, 480.2148487223415, 481.0787342239642, 482.90583336249796, 3681.318955993096, 3685.8341374638208, 3702.7037836972977, 3706.221693444353, 3731.6454936781506, 10859.891401086046, 11271.154663400113, 11356.829647555292, 11431.59989400367, 11435.142364322543, 11308.982191602796, 11327.546898124148, 11330.37682927447, 11331.830022549504, 11335.263207891461, 8437.831243375222, 8511.574421279036, 8584.613692383733, 8652.913470865336, 8653.26447251978, 5522.116461366162, 5599.80400685974, 5675.404082571271, 5690.971545142248, 5715.39988301239, 10221.386716797017, 10328.638497652546, 10331.84502232452, 10500.422476763852, 10513.421761803174, 10687.946560267148, 10688.038076572835, 10780.568777248822, 10780.676579702622, 10793.136549076213, 6674.799756007327, 6836.418904393182, 6839.760608378683, 7355.8161045974275, 7449.255074492507, 7666.348360389206, 8180.100188979089, 8223.506589604644, 8438.156184381513, 8441.36689748259, 7413.962930185315, 7432.442566807403, 7534.773956781305, 7554.924450755422, 7648.732294369893, 7571.507851989603, 7581.962090189734, 7604.277593628596, 7658.042744656918, 7682.0, 6582.670866456754, 6730.822106131505, 6739.494537909578, 6741.966290168518, 6742.8651426972165, 4951.801927922843, 4996.2505624156665, 5032.6980381177245, 5040.117979353525, 5199.92200116991, 4831.95168048315, 4883.6093112551625, 4897.0, 5006.949930500648, 5065.620078494201], "value": 4566.104862916144, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.23460275968034, 343.56367413385, 351.715110760284, 353.85315094235887, 357.10545084563165, 5411.91882121768, 5451.454854514546, 5460.044492213867, 5460.215290201996, 5475.890482190353, 5138.0, 5214.921776173361, 5234.450382709818, 5331.626786124973, 5395.7032363220005, 4212.157568486315, 4246.57534246576, 4261.169072030955, 4264.317709166534, 4270.572942705736, 4265.573442655741, 4267.530571637118, 4281.785910704468, 4282.379055037018, 4286.592773686495, 4125.257453658341, 4231.640310573605, 4241.172971270604, 4252.447181866353, 4269.786510674469, 4228.682848786353, 4232.978670263232, 4242.384854196124, 4255.170241802834, 4263.211305908401, 3808.3906574947873, 3808.409696497047, 3810.5236845394325, 3825.8469661213517, 3828.636279553438, 5019.548240658358, 5228.294180285651, 5245.86885327866, 5254.52709256165, 5281.260623512711, 4865.8783530411665, 4872.3909511311085, 4881.609471242292, 4890.877728056791, 4891.486393928657, 5602.24369710088, 5652.265205523297, 5655.547556195535, 5659.943400565983, 5666.470053085685, 4030.2544029354663, 4094.6928980326593, 4133.42132101506, 4136.152088821785, 4149.3775933609895, 5811.564132690065, 5825.533957283407, 5832.591718579701, 5836.066229403317, 5841.4450627190345, 4195.811188496525, 4206.684498662551, 4207.410962465257, 4211.1998720243055, 4225.176090662291, 4159.667226621863, 4247.110036033997, 4303.139372125587, 4304.612584867377, 4306.849260275938, 4827.444843842933, 4838.395200599925, 4840.201366774443, 4875.829345972945, 4883.096627123993, 5628.718564071862, 5649.0396632572565, 5719.48524632785, 5734.627249228787, 5735.483806457439, 1407.7254935287726, 1413.0, 1413.1450472464217, 1421.0, 1424.9740187065297, 977.9413235205768, 982.9262805289488, 985.9556319965619, 988.313122379939, 1005.2410430125354, 5170.896582068338, 5183.222516622537, 5191.32512773337, 5208.218767184952, 5210.843674689765, 5517.806876759294, 5542.972285138549, 5567.888642227133, 5576.637518561281, 5596.132599447093, 5012.974935125301, 5212.6638951071345, 5226.97386513065, 5255.894882102413, 5260.579153667697, 2928.7656987440955, 2939.5884576159356, 2939.9412011759646, 2947.437857935298, 2952.188148259203, 5597.74810133545, 5618.438156184349, 5625.437456254342, 5640.605157639008, 5645.802396916089, 5620.587838546803, 5653.717314134359, 5911.793087242012, 5928.822135335947, 5945.286565612154, 5943.940560594425, 5954.8809023819285, 5968.910881191635, 5978.641281523122, 5982.312034116132, 5628.4090170533145, 5734.3978882218435, 5822.214001109796, 5843.7370318336625, 5862.706864656665, 5767.567432442667, 5770.567207459541, 5783.306003279633, 5800.651960882361, 5802.65184088956, 5936.732847021808, 5949.52403807703, 5988.8802223956145, 6006.87986240264, 6038.396160383926, 4000.6796058286704, 4160.958390416178, 4175.707700460938, 4253.276942919773, 4259.595338442843, 5575.721213939368, 5711.3431955324, 5745.540356771365, 5814.0, 5815.0, 5660.20757093999, 5733.168690539932, 5735.254416925773, 5749.080147176432, 5780.306363236438, 5600.57995650336, 5696.772129114789, 5727.455891690282, 5738.167965644875, 5740.741666625096, 5685.77256909719, 5698.466950490722, 5701.287339082614, 5717.7141142941855, 5729.828105156852, 5687.1753595729215, 5732.3121225453215, 5733.082706766897, 5751.4536119068625, 5779.248697669276, 5388.326459192601, 5544.306961629796, 5571.4121475379325, 5588.217649529151, 5604.047311957059], "value": 4315.1788514235295, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.4012589299097, 725.58278989581, 754.2495217258825, 775.4223103787677, 799.804048008238, 15290.847091529082, 15930.442434514795, 15952.883298169147, 15954.361825526994, 16015.919920400396, 13842.930785346085, 13876.791848122286, 13916.0, 13932.51236206733, 13934.51229206978, 727.0330460487539, 729.1651059536854, 845.8054647431095, 846.5724808971477, 868.0191383736369, 851.7231899632613, 864.2524216552669, 870.7605408512646, 871.1375738019346, 871.1767379826067, 922.3912217936163, 922.6632279218071, 923.6628630549868, 923.9630414783434, 924.5654542365078, 915.2815040193483, 915.4964769376816, 916.3493919317293, 916.7387294621034, 917.1424717888796, 676.972921083156, 677.6848765324098, 679.1035832700837, 679.8368391585984, 680.6358598150016, 14530.782038269434, 15032.398704051935, 15059.397624095023, 15098.16960067196, 15129.924350378287, 13921.58235252934, 14813.55559333211, 14942.925285373612, 15164.620884477867, 15238.466653667068, 10695.304805187716, 10726.195535334804, 10790.946045269802, 10804.0816530595, 10849.349039057683, 3722.7021838252876, 3744.8314825832904, 3809.580946095927, 3811.8284677189595, 3818.5966856897458, 64432.0, 64822.0, 66102.3389766101, 66165.3383466164, 66367.66816165937, 10694.091002264739, 10818.67543973682, 10837.945810271056, 10903.890961090288, 10984.560617575207, 19317.80682193188, 19675.21299148047, 19982.10080546379, 20198.0, 20253.49366265855, 7615.885761713579, 8054.114047454776, 8166.346692264605, 8241.175882411711, 8376.036755773042, 4454.532274111171, 4464.888377790581, 4539.228331183706, 4641.791119399635, 4651.09303685778, 3295.6374798772117, 3346.347462244839, 3365.9495107573407, 3387.542681737983, 3413.965860341365, 579.7536047179932, 585.5988647776287, 595.5027551994046, 606.6572386601556, 626.5582764151262, 557.3896583241344, 559.3735016781231, 607.9694917115535, 628.5286035473395, 642.6979319719725, 8112.594370281462, 8881.37830351882, 9085.68200113006, 9395.483248421402, 9434.433933963985, 582.6911736779514, 597.0742368924253, 643.427349658804, 649.2792999770252, 652.3248437866785, 4119.0, 4175.937360939588, 4282.507511636201, 4318.30907054876, 4416.867493975186, 51420.0, 59381.0, 72339.0, 83231.0, 87260.12739872647, 46622.53377466182, 57881.710591446776, 71101.2889871105, 74458.0, 75254.62372688102, 67271.66364168246, 68729.65635171892, 70344.0, 71755.64122179356, 72431.99999999895, 8390.454620449651, 8417.83164336722, 8581.442206256574, 8592.0, 8728.519931403835, 43581.78209108934, 44090.55909440864, 45059.54940450554, 45093.32360014537, 47068.29397558971, 59491.40508594859, 63958.36041639524, 65394.34605653882, 65420.67289663521, 65528.689426212164, 10077.899221007989, 10382.532786024798, 10434.947825261128, 10446.05985461312, 11263.042641375574, 11332.376719280519, 11656.766864662828, 11677.240979336317, 11692.064634829363, 11806.350650714294, 10097.495125243855, 10097.798044039226, 10220.488975551341, 10370.896291036994, 12205.938970305091, 12252.632421027383, 12617.747645046864, 12656.493740250287, 12756.362181891054, 12836.679083022998, 11609.0, 11834.58578949767, 12022.639320820039, 12550.560730374393, 12681.048921331121, 10335.17318614524, 10358.896411035794, 10483.0, 10982.560697572007, 11072.612458563912, 10646.946765266433, 10721.517531710935, 10816.498526383195, 11027.889721102687, 11158.330500170016], "value": 6908.772324272654, "unit": "score"}], "name": "dromaeo_css", "value": 7184.424263760361, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 109.0, 112.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 111.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 118.0, 118.0, 161.0, 122.0, 123.0, 117.0, 117.0, 141.0, 116.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 160.0, 162.0, 160.0, 161.0, 160.0, 160.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 101.0, 75.0, 76.0, 74.0, 74.0, 96.0, 74.0], "value": 79.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 131.0, 81.0, 81.0, 82.0, 97.0, 82.0, 81.0, 109.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 147.0, 147.0, 147.0, 148.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 87.0, 85.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 50.0, 52.0, 51.0, 52.0, 52.0, 51.0, 51.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 60.0, 63.0, 61.0, 60.0, 61.0, 60.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 78.0, 84.0, 80.0, 75.0, 74.0, 75.0, 74.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 123.0, 124.0, 128.0, 132.0, 120.0, 121.0, 130.0, 158.0, 124.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 161.0, 163.0, 158.0, 163.0, 160.0, 160.0, 159.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 62.0, 65.0, 64.0, 64.0, 62.0, 62.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1458.3, "alertThreshold": 2.0}]} 21:17:30 INFO - Return code: 0 21:17:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:17:30 INFO - # TBPL SUCCESS # 21:17:30 INFO - Running post-action listener: _resource_record_post_action 21:17:30 INFO - [mozharness: 2017-02-10 05:17:30.557562Z] Finished run-tests step (success) 21:17:30 INFO - Running post-run listener: _resource_record_post_run 21:17:30 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 333766656; Read time: 0; Write time: 276476 21:17:30 INFO - TinderboxPrint: CPU usage
12.9% 21:17:30 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 21:17:30 INFO - TinderboxPrint: I/O write bytes / time
333,766,656 / 276,476 21:17:30 INFO - TinderboxPrint: CPU idle
8,257.4 (87.1%) 21:17:30 INFO - TinderboxPrint: CPU user
1,184.2 (12.5%) 21:17:30 INFO - TinderboxPrint: Swap in / out
0 / 0 21:17:30 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 112513024; Read time: 0; Write time: 103660 21:17:30 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 221253632; Read time: 0; Write time: 172816 21:17:31 INFO - Running post-run listener: _upload_blobber_files 21:17:31 INFO - Blob upload gear active. 21:17:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:17:31 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 21:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:17:31 INFO - (blobuploader) - INFO - Open directory for files ... 21:17:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:17:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:17:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:17:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:17:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:17:35 INFO - (blobuploader) - INFO - Done attempting. 21:17:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:17:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:17:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:17:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:17:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:17:35 INFO - (blobuploader) - INFO - Done attempting. 21:17:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:17:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:17:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:17:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:17:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:17:36 INFO - (blobuploader) - INFO - Done attempting. 21:17:36 INFO - (blobuploader) - INFO - Iteration through files over. 21:17:36 INFO - Return code: 0 21:17:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:17:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:17:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/19500c964243502a58a5d908516524c94f7ceda0dc811aaa6433e7a381a13887637b58b5b7f359f299255245d056e6fb2233988c3404b21abb5399fb26599106", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bcf0ee93fa2c4bb7b2c82b14cc72fcfcefd2866753785dc21aff9ccd79b9bb1d2f677f2516bd7ba74561acadf4b0552ae0489ddcea976ff9efc67968f9200325", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0c8dcaf79bcb850f00e33ffab7e7e3de615ec26b83358f1144db9f06f32eb35995e9558affcf09b18f5809345df10280e603901beedfea9910ad3b6d2ee86fe"} 21:17:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:17:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:17:36 INFO - Contents: 21:17:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/19500c964243502a58a5d908516524c94f7ceda0dc811aaa6433e7a381a13887637b58b5b7f359f299255245d056e6fb2233988c3404b21abb5399fb26599106", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bcf0ee93fa2c4bb7b2c82b14cc72fcfcefd2866753785dc21aff9ccd79b9bb1d2f677f2516bd7ba74561acadf4b0552ae0489ddcea976ff9efc67968f9200325", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0c8dcaf79bcb850f00e33ffab7e7e3de615ec26b83358f1144db9f06f32eb35995e9558affcf09b18f5809345df10280e603901beedfea9910ad3b6d2ee86fe"} 21:17:36 INFO - Running post-run listener: copy_logs_to_upload_dir 21:17:36 INFO - Copying logs to upload dir... 21:17:36 INFO - mkdir: /builds/slave/test/build/upload/logs 21:17:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.555565 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-02-09 21:17:36.382836) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 21:17:36.386221) ========= 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=5c37b704b588aaa989324530000001d0-1486702425.274507-378251389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/19500c964243502a58a5d908516524c94f7ceda0dc811aaa6433e7a381a13887637b58b5b7f359f299255245d056e6fb2233988c3404b21abb5399fb26599106", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bcf0ee93fa2c4bb7b2c82b14cc72fcfcefd2866753785dc21aff9ccd79b9bb1d2f677f2516bd7ba74561acadf4b0552ae0489ddcea976ff9efc67968f9200325", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0c8dcaf79bcb850f00e33ffab7e7e3de615ec26b83358f1144db9f06f32eb35995e9558affcf09b18f5809345df10280e603901beedfea9910ad3b6d2ee86fe"} build_url:https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011431 build_url: 'https://queue.taskcluster.net/v1/task/CuamsxsHQmyj5iNtg2zLxQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/19500c964243502a58a5d908516524c94f7ceda0dc811aaa6433e7a381a13887637b58b5b7f359f299255245d056e6fb2233988c3404b21abb5399fb26599106", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bcf0ee93fa2c4bb7b2c82b14cc72fcfcefd2866753785dc21aff9ccd79b9bb1d2f677f2516bd7ba74561acadf4b0552ae0489ddcea976ff9efc67968f9200325", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0c8dcaf79bcb850f00e33ffab7e7e3de615ec26b83358f1144db9f06f32eb35995e9558affcf09b18f5809345df10280e603901beedfea9910ad3b6d2ee86fe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 21:17:36.411548) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 21:17:36.411903) ========= 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=5c37b704b588aaa989324530000001d0-1486702425.274507-378251389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 21:17:36.496555) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 21:17:36.496900) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 21:17:36.497275) ========= ========= Total master_lag: 0.80 =========