builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1480151617.28 results: success (0) buildid: 20161125223004 builduid: a602071278a74d448309a239a9095d0e revision: f8f4eaac1701107f794b48891bcca2c95d39d503 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 01:13:37.285126) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 01:13:37.285604) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 01:13:37.285893) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 01:13:37.300354) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 01:13:37.300633) ========= 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=41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-26 01:13:37-- 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% 95.9M=0s 2016-11-26 01:13:37 (95.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135188 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 01:13:37.450092) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 01:13:37.450371) ========= 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=41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016866 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 01:13:37.500103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-26 01:13:37.500406) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f8f4eaac1701107f794b48891bcca2c95d39d503 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f8f4eaac1701107f794b48891bcca2c95d39d503 --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=41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-26 01:13:38,051 truncating revision to first 12 chars 2016-11-26 01:13:38,051 Setting DEBUG logging. 2016-11-26 01:13:38,051 attempt 1/10 2016-11-26 01:13:38,051 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f8f4eaac1701?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-26 01:13:38,889 unpacking tar archive at: mozilla-central-f8f4eaac1701/testing/mozharness/ program finished with exit code 0 elapsedTime=1.114559 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-26 01:13:38.627778) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 01:13:38.628048) ========= script_repo_revision: f8f4eaac1701107f794b48891bcca2c95d39d503 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 01:13:38.628434) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 01:13:38.628718) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 01:13:38.640853) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-26 01:13:38.641140) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:13:39 INFO - MultiFileLogger online at 20161126 01:13:39 in /builds/slave/test 01:13:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 01:13:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:13:39 INFO - {'append_to_log': False, 01:13:39 INFO - 'base_work_dir': '/builds/slave/test', 01:13:39 INFO - 'blob_upload_branch': 'Firefox', 01:13:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:13:39 INFO - 'branch': 'Firefox', 01:13:39 INFO - 'buildbot_json_path': 'buildprops.json', 01:13:39 INFO - 'config_files': ('talos/linux_config.py',), 01:13:39 INFO - 'default_actions': ('clobber', 01:13:39 INFO - 'read-buildbot-config', 01:13:39 INFO - 'download-and-extract', 01:13:39 INFO - 'populate-webroot', 01:13:39 INFO - 'create-virtualenv', 01:13:39 INFO - 'install', 01:13:39 INFO - 'run-tests'), 01:13:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:13:39 INFO - 'download_minidump_stackwalk': True, 01:13:39 INFO - 'download_symbols': 'ondemand', 01:13:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:13:39 INFO - 'tooltool.py': '/tools/tooltool.py', 01:13:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:13:39 INFO - '/tools/misc-python/virtualenv.py')}, 01:13:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:13:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:13:39 INFO - 'installer_path': 'installer.exe', 01:13:39 INFO - 'log_level': 'info', 01:13:39 INFO - 'log_name': 'talos', 01:13:39 INFO - 'log_to_console': True, 01:13:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:13:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:13:39 INFO - 'opt_config_files': (), 01:13:39 INFO - 'pip_index': False, 01:13:39 INFO - 'sps_profile': False, 01:13:39 INFO - 'sps_profile_interval': 0, 01:13:39 INFO - 'suite': 'dromaeojs-e10s', 01:13:39 INFO - 'system_bits': '32', 01:13:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:13:39 INFO - 'title': 'talos-linux64-ix-026', 01:13:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:13:39 INFO - 'use_talos_json': True, 01:13:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:13:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:13:39 INFO - 'work_dir': 'build'} 01:13:39 INFO - [mozharness: 2016-11-26 09:13:39.291303Z] Running clobber step. 01:13:39 INFO - Running pre-action listener: _resource_record_pre_action 01:13:39 INFO - Running main action method: clobber 01:13:39 INFO - rmtree: /builds/slave/test/build 01:13:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:13:40 INFO - Running post-action listener: _resource_record_post_action 01:13:40 INFO - [mozharness: 2016-11-26 09:13:40.292522Z] Finished clobber step (success) 01:13:40 INFO - [mozharness: 2016-11-26 09:13:40.292621Z] Running read-buildbot-config step. 01:13:40 INFO - Running pre-action listener: _resource_record_pre_action 01:13:40 INFO - Running main action method: read_buildbot_config 01:13:40 INFO - Using buildbot properties: 01:13:40 INFO - { 01:13:40 INFO - "project": "", 01:13:40 INFO - "product": "firefox", 01:13:40 INFO - "script_repo_revision": "production", 01:13:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 01:13:40 INFO - "repository": "", 01:13:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 01:13:40 INFO - "buildid": "20161125223004", 01:13:40 INFO - "pgo_build": "True", 01:13:40 INFO - "basedir": "/builds/slave/test", 01:13:40 INFO - "buildnumber": 205, 01:13:40 INFO - "slavename": "talos-linux64-ix-026", 01:13:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:13:40 INFO - "platform": "ubuntu64_hw", 01:13:40 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 01:13:40 INFO - "branch": "mozilla-central", 01:13:40 INFO - "repo_path": "mozilla-central", 01:13:40 INFO - "revision": "f8f4eaac1701107f794b48891bcca2c95d39d503", 01:13:40 INFO - "stage_platform": "linux64-pgo", 01:13:40 INFO - "builduid": "a602071278a74d448309a239a9095d0e", 01:13:40 INFO - "slavebuilddir": "test" 01:13:40 INFO - } 01:13:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 01:13:40 INFO - Running post-action listener: _resource_record_post_action 01:13:40 INFO - [mozharness: 2016-11-26 09:13:40.295064Z] Finished read-buildbot-config step (success) 01:13:40 INFO - [mozharness: 2016-11-26 09:13:40.295153Z] Running download-and-extract step. 01:13:40 INFO - Running pre-action listener: _resource_record_pre_action 01:13:40 INFO - Running main action method: download_and_extract 01:13:40 INFO - mkdir: /builds/slave/test/build/tests 01:13:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:13:40 INFO - trying https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 01:13:40 INFO - Downloading https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 01:13:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:13:40 INFO - Downloaded 1361 bytes. 01:13:40 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 01:13:40 INFO - Using the following test package requirements: 01:13:40 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 01:13:40 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:13:40 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:13:40 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:40 INFO - u'jsshell-linux-x86_64.zip'], 01:13:40 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:13:40 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 01:13:40 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:13:40 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:13:40 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:13:40 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:13:40 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:13:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 01:13:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:13:40 INFO - Fetch https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:13:41 INFO - Http code: 200 01:13:41 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 01:13:41 INFO - x-amz-cf-id: fq_VR_F7YHjS7J5Pn6hktPiTYpmar5jlKGOJuNJSCnCBkgGKNFUZgw== 01:13:41 INFO - x-amz-version-id: v7JPWfmhScwTrn8.BITvgsB5_qno6W7x 01:13:41 INFO - Expected file size: 21770492 01:13:41 INFO - Obtained file size: 21770492 01:13:45 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:13:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 01:13:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:13:45 INFO - Fetch https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:13:46 INFO - Http code: 200 01:13:46 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 01:13:46 INFO - x-amz-cf-id: o_NhjQJbuqW4Mvo3hph4g2b1XcKV-MV7_5ND-CsuZySrZmTw-Wt-vg== 01:13:46 INFO - x-amz-version-id: v7JPWfmhScwTrn8.BITvgsB5_qno6W7x 01:13:46 INFO - Expected file size: 21770492 01:13:46 INFO - Obtained file size: 21770492 01:13:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 01:13:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:13:51 INFO - Fetch https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 01:13:51 INFO - Http code: 200 01:13:51 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 01:13:51 INFO - x-amz-cf-id: 37vnVspCtMeASPX1PVq7H-GQ-ljJ-FoN7ltVElQzBi1nMja9VkD98g== 01:13:51 INFO - x-amz-version-id: wZkaXbTuUxtD5joOBpEpSmnkosAfR_7c 01:13:51 INFO - Expected file size: 14409702 01:13:51 INFO - Obtained file size: 14409702 01:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:13:51 INFO - trying https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:13:51 INFO - Downloading https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:13:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:13:53 INFO - Downloaded 59807490 bytes. 01:13:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:13:53 INFO - mkdir: /builds/slave/test/properties 01:13:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:13:53 INFO - Writing to file /builds/slave/test/properties/build_url 01:13:53 INFO - Contents: 01:13:53 INFO - build_url:https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:13:53 INFO - Running post-action listener: _resource_record_post_action 01:13:53 INFO - Running post-action listener: set_extra_try_arguments 01:13:53 INFO - [mozharness: 2016-11-26 09:13:53.988518Z] Finished download-and-extract step (success) 01:13:53 INFO - [mozharness: 2016-11-26 09:13:53.988745Z] Running populate-webroot step. 01:13:53 INFO - Running pre-action listener: _resource_record_pre_action 01:13:53 INFO - Running main action method: populate_webroot 01:13:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:13:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:13:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:13:54 INFO - '--tppagecycles', 01:13:54 INFO - '7'], 01:13:54 INFO - 'tests': ['tsvgm']}}, 01:13:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:13:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:13:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:13:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:13:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:13:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:13:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:13:54 INFO - 'talos_options': ['--disable-e10s'], 01:13:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:13:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:13:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:13:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:13:54 INFO - 'talos_options': ['--disable-e10s'], 01:13:54 INFO - 'tests': ['damp', 'tps']}, 01:13:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:13:54 INFO - 'tests': ['damp', 'tps']}, 01:13:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:13:54 INFO - 'tests': ['dromaeo_dom']}, 01:13:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:13:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:13:54 INFO - 'tests': ['basic_compositor_video']}, 01:13:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:13:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:13:54 INFO - 'tests': ['a11yr', 01:13:54 INFO - 'ts_paint', 01:13:54 INFO - 'tpaint', 01:13:54 INFO - 'sessionrestore', 01:13:54 INFO - 'sessionrestore_no_auto_restore', 01:13:54 INFO - 'tabpaint']}, 01:13:54 INFO - 'other-e10s': {'tests': ['a11yr', 01:13:54 INFO - 'ts_paint', 01:13:54 INFO - 'tpaint', 01:13:54 INFO - 'sessionrestore', 01:13:54 INFO - 'sessionrestore_no_auto_restore', 01:13:54 INFO - 'tabpaint']}, 01:13:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:13:54 INFO - 'ts_paint', 01:13:54 INFO - 'tpaint', 01:13:54 INFO - 'sessionrestore', 01:13:54 INFO - 'sessionrestore_no_auto_restore', 01:13:54 INFO - 'tabpaint']}, 01:13:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:13:54 INFO - 'ts_paint', 01:13:54 INFO - 'tpaint', 01:13:54 INFO - 'sessionrestore', 01:13:54 INFO - 'sessionrestore_no_auto_restore', 01:13:54 INFO - 'tabpaint']}, 01:13:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:13:54 INFO - 'tests': ['a11yr', 01:13:54 INFO - 'ts_paint', 01:13:54 INFO - 'tpaint', 01:13:54 INFO - 'sessionrestore', 01:13:54 INFO - 'sessionrestore_no_auto_restore', 01:13:54 INFO - 'tabpaint']}, 01:13:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:13:54 INFO - 'tests': ['a11yr', 01:13:54 INFO - 'ts_paint', 01:13:54 INFO - 'tpaint', 01:13:54 INFO - 'sessionrestore', 01:13:54 INFO - 'sessionrestore_no_auto_restore', 01:13:54 INFO - 'tabpaint']}, 01:13:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:13:54 INFO - 'tests': ['tsvgx', 01:13:54 INFO - 'tsvgr_opacity', 01:13:54 INFO - 'tart', 01:13:54 INFO - 'tscrollx', 01:13:54 INFO - 'cart', 01:13:54 INFO - 'tsvg_static']}, 01:13:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:13:54 INFO - 'tsvgr_opacity', 01:13:54 INFO - 'tart', 01:13:54 INFO - 'tscrollx', 01:13:54 INFO - 'cart', 01:13:54 INFO - 'tsvg_static']}, 01:13:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:13:54 INFO - 'talos_options': ['--disable-e10s'], 01:13:54 INFO - 'tests': ['tp5o']}, 01:13:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:13:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:13:54 INFO - 'talos_options': ['--disable-e10s', 01:13:54 INFO - '--xperf_path', 01:13:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:13:54 INFO - 'tests': ['tp5n']}, 01:13:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:13:54 INFO - 'talos_options': ['--xperf_path', 01:13:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:13:54 INFO - 'tests': ['tp5n']}}, 01:13:54 INFO - 'talos.zip': {'path': '', 01:13:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:13:54 INFO - Running post-action listener: _resource_record_post_action 01:13:54 INFO - [mozharness: 2016-11-26 09:13:54.007679Z] Finished populate-webroot step (success) 01:13:54 INFO - [mozharness: 2016-11-26 09:13:54.007768Z] Running create-virtualenv step. 01:13:54 INFO - Running pre-action listener: _resource_record_pre_action 01:13:54 INFO - Running main action method: create_virtualenv 01:13:54 INFO - Creating virtualenv /builds/slave/test/build/venv 01:13:54 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 01:13:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:13:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:13:54 INFO - Using real prefix '/usr' 01:13:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:13:54 INFO - Installing distribute.............................................................................................................................................................................................done. 01:13:56 INFO - Installing pip.................done. 01:13:56 INFO - Return code: 0 01:13:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:13:56 INFO - Reading from file tmpfile_stdout 01:13:56 INFO - Output received: 01:13:56 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) 01:13:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:13: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')]} 01:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13: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')]} 01:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8083428e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dafc0>, '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 0x16dbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc350>, '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': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', '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 01:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:13:56 INFO - Using env: {'DISPLAY': ':0', 01:13:56 INFO - 'HOME': '/home/cltbld', 01:13:56 INFO - 'LANG': 'en_US.UTF-8', 01:13:56 INFO - 'LANGUAGE': 'en_US:en', 01:13:56 INFO - 'LOGNAME': 'cltbld', 01:13:56 INFO - 'MAIL': '/var/mail/cltbld', 01:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:56 INFO - 'MOZ_NO_REMOTE': '1', 01:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:56 INFO - 'NO_EM_RESTART': '1', 01:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:56 INFO - 'PWD': '/builds/slave/test', 01:13:56 INFO - 'SHELL': '/bin/bash', 01:13:56 INFO - 'SHLVL': '1', 01:13:56 INFO - 'TERM': 'linux', 01:13:56 INFO - 'TMOUT': '86400', 01:13:56 INFO - 'USER': 'cltbld', 01:13:56 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', 01:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:56 INFO - '_': '/tools/buildbot/bin/python'} 01:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:57 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 01:13:57 INFO - Cleaning up... 01:13:57 INFO - Return code: 0 01:13:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8083428e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dafc0>, '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 0x16dbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc350>, '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': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', '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 01:13:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:13:57 INFO - Using env: {'DISPLAY': ':0', 01:13:57 INFO - 'HOME': '/home/cltbld', 01:13:57 INFO - 'LANG': 'en_US.UTF-8', 01:13:57 INFO - 'LANGUAGE': 'en_US:en', 01:13:57 INFO - 'LOGNAME': 'cltbld', 01:13:57 INFO - 'MAIL': '/var/mail/cltbld', 01:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:57 INFO - 'MOZ_NO_REMOTE': '1', 01:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:57 INFO - 'NO_EM_RESTART': '1', 01:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:57 INFO - 'PWD': '/builds/slave/test', 01:13:57 INFO - 'SHELL': '/bin/bash', 01:13:57 INFO - 'SHLVL': '1', 01:13:57 INFO - 'TERM': 'linux', 01:13:57 INFO - 'TMOUT': '86400', 01:13:57 INFO - 'USER': 'cltbld', 01:13:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', 01:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:57 INFO - '_': '/tools/buildbot/bin/python'} 01:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:57 INFO - Downloading/unpacking psutil>=3.1.1 01:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:13:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:13:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:13:59 INFO - Installing collected packages: psutil 01:13:59 INFO - Running setup.py install for psutil 01:13:59 INFO - building 'psutil._psutil_linux' extension 01:13:59 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 01:13:59 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 01:13:59 INFO - building 'psutil._psutil_posix' extension 01:13:59 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 01:13:59 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 01:13:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:13:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:13:59 INFO - Successfully installed psutil 01:13:59 INFO - Cleaning up... 01:13:59 INFO - Return code: 0 01:13:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8083428e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dafc0>, '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 0x16dbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc350>, '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': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', '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 01:13:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:13:59 INFO - Using env: {'DISPLAY': ':0', 01:13:59 INFO - 'HOME': '/home/cltbld', 01:13:59 INFO - 'LANG': 'en_US.UTF-8', 01:13:59 INFO - 'LANGUAGE': 'en_US:en', 01:13:59 INFO - 'LOGNAME': 'cltbld', 01:13:59 INFO - 'MAIL': '/var/mail/cltbld', 01:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:59 INFO - 'MOZ_NO_REMOTE': '1', 01:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:59 INFO - 'NO_EM_RESTART': '1', 01:13:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:59 INFO - 'PWD': '/builds/slave/test', 01:13:59 INFO - 'SHELL': '/bin/bash', 01:13:59 INFO - 'SHLVL': '1', 01:13:59 INFO - 'TERM': 'linux', 01:13:59 INFO - 'TMOUT': '86400', 01:13:59 INFO - 'USER': 'cltbld', 01:13:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', 01:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:59 INFO - '_': '/tools/buildbot/bin/python'} 01:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:14:02 INFO - Installing collected packages: mozsystemmonitor 01:14:02 INFO - Running setup.py install for mozsystemmonitor 01:14:02 INFO - Successfully installed mozsystemmonitor 01:14:02 INFO - Cleaning up... 01:14:02 INFO - Return code: 0 01:14:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:14:02 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')]} 01:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:02 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')]} 01:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:02 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 0x7f8083428e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dafc0>, '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 0x16dbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc350>, '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': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', '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 01:14:02 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 01:14:02 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 01:14:02 INFO - Using env: {'DISPLAY': ':0', 01:14:02 INFO - 'HOME': '/home/cltbld', 01:14:02 INFO - 'LANG': 'en_US.UTF-8', 01:14:02 INFO - 'LANGUAGE': 'en_US:en', 01:14:02 INFO - 'LOGNAME': 'cltbld', 01:14:02 INFO - 'MAIL': '/var/mail/cltbld', 01:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:02 INFO - 'MOZ_NO_REMOTE': '1', 01:14:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:02 INFO - 'NO_EM_RESTART': '1', 01:14:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:02 INFO - 'PWD': '/builds/slave/test', 01:14:02 INFO - 'SHELL': '/bin/bash', 01:14:02 INFO - 'SHLVL': '1', 01:14:02 INFO - 'TERM': 'linux', 01:14:02 INFO - 'TMOUT': '86400', 01:14:02 INFO - 'USER': 'cltbld', 01:14:02 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', 01:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:02 INFO - '_': '/tools/buildbot/bin/python'} 01:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:02 INFO - Downloading/unpacking jsonschema==2.5.1 01:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:14:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:14:04 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 01:14:04 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 01:14:04 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 01:14:04 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 01:14:04 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 01:14:04 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 01:14:04 INFO - Downloading functools32-3.2.3-2.tar.gz 01:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:14:04 INFO - warning: no files found matching '*.txt' 01:14:04 INFO - no previously-included directories found matching 'build' 01:14:04 INFO - no previously-included directories found matching 'dist' 01:14:04 INFO - no previously-included directories found matching '.git*' 01:14:04 INFO - Installing collected packages: jsonschema, functools32 01:14:04 INFO - Running setup.py install for functools32 01:14:04 INFO - warning: no files found matching '*.txt' 01:14:04 INFO - no previously-included directories found matching 'build' 01:14:04 INFO - no previously-included directories found matching 'dist' 01:14:04 INFO - no previously-included directories found matching '.git*' 01:14:04 INFO - Successfully installed jsonschema functools32 01:14:04 INFO - Cleaning up... 01:14:04 INFO - Return code: 0 01:14:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:14:04 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')]} 01:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:04 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')]} 01:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:04 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 0x7f8083428e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dafc0>, '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 0x16dbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc350>, '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': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', '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 01:14:04 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 01:14:04 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 01:14:04 INFO - Using env: {'DISPLAY': ':0', 01:14:04 INFO - 'HOME': '/home/cltbld', 01:14:04 INFO - 'LANG': 'en_US.UTF-8', 01:14:04 INFO - 'LANGUAGE': 'en_US:en', 01:14:04 INFO - 'LOGNAME': 'cltbld', 01:14:04 INFO - 'MAIL': '/var/mail/cltbld', 01:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:04 INFO - 'MOZ_NO_REMOTE': '1', 01:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:04 INFO - 'NO_EM_RESTART': '1', 01:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:04 INFO - 'PWD': '/builds/slave/test', 01:14:04 INFO - 'SHELL': '/bin/bash', 01:14:04 INFO - 'SHLVL': '1', 01:14:04 INFO - 'TERM': 'linux', 01:14:04 INFO - 'TMOUT': '86400', 01:14:04 INFO - 'USER': 'cltbld', 01:14:04 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', 01:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:04 INFO - '_': '/tools/buildbot/bin/python'} 01:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:14:05 INFO - Cleaning up... 01:14:05 INFO - Return code: 0 01:14:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:14: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')]} 01:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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')]} 01:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:05 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 0x7f8083428e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dafc0>, '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 0x16dbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc350>, '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': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', '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 01:14:05 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 01:14:05 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 01:14:05 INFO - Using env: {'DISPLAY': ':0', 01:14:05 INFO - 'HOME': '/home/cltbld', 01:14:05 INFO - 'LANG': 'en_US.UTF-8', 01:14:05 INFO - 'LANGUAGE': 'en_US:en', 01:14:05 INFO - 'LOGNAME': 'cltbld', 01:14:05 INFO - 'MAIL': '/var/mail/cltbld', 01:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:05 INFO - 'MOZ_NO_REMOTE': '1', 01:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:05 INFO - 'NO_EM_RESTART': '1', 01:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:05 INFO - 'PWD': '/builds/slave/test', 01:14:05 INFO - 'SHELL': '/bin/bash', 01:14:05 INFO - 'SHLVL': '1', 01:14:05 INFO - 'TERM': 'linux', 01:14:05 INFO - 'TMOUT': '86400', 01:14:05 INFO - 'USER': 'cltbld', 01:14:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', 01:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:05 INFO - '_': '/tools/buildbot/bin/python'} 01:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:05 INFO - Downloading/unpacking blobuploader==1.2.4 01:14:05 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 01:14:05 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 01:14:05 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 01:14:05 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 01:14:05 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 01:14:05 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 01:14:07 INFO - Downloading blobuploader-1.2.4.tar.gz 01:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:14:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:14:07 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 01:14:07 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 01:14:07 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 01:14:07 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 01:14:07 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 01:14:07 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 01:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:14:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:14:07 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 01:14:07 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 01:14:07 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 01:14:07 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 01:14:07 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 01:14:07 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 01:14:07 INFO - Downloading docopt-0.6.1.tar.gz 01:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:14:08 INFO - Installing collected packages: blobuploader, requests, docopt 01:14:08 INFO - Running setup.py install for blobuploader 01:14:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:14:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:14:08 INFO - Running setup.py install for requests 01:14:08 INFO - Running setup.py install for docopt 01:14:08 INFO - Successfully installed blobuploader requests docopt 01:14:08 INFO - Cleaning up... 01:14:08 INFO - Return code: 0 01:14:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:14:08 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')]} 01:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:08 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')]} 01:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:08 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 0x7f8083428e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dafc0>, '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 0x16dbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc350>, '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': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', '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 01:14:08 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 01:14:08 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 01:14:08 INFO - Using env: {'DISPLAY': ':0', 01:14:08 INFO - 'HOME': '/home/cltbld', 01:14:08 INFO - 'LANG': 'en_US.UTF-8', 01:14:08 INFO - 'LANGUAGE': 'en_US:en', 01:14:08 INFO - 'LOGNAME': 'cltbld', 01:14:08 INFO - 'MAIL': '/var/mail/cltbld', 01:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:08 INFO - 'MOZ_NO_REMOTE': '1', 01:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:08 INFO - 'NO_EM_RESTART': '1', 01:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:08 INFO - 'PWD': '/builds/slave/test', 01:14:08 INFO - 'SHELL': '/bin/bash', 01:14:08 INFO - 'SHLVL': '1', 01:14:08 INFO - 'TERM': 'linux', 01:14:08 INFO - 'TMOUT': '86400', 01:14:08 INFO - 'USER': 'cltbld', 01:14:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', 01:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:08 INFO - '_': '/tools/buildbot/bin/python'} 01:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:14:08 INFO - Running setup.py (path:/tmp/pip-dM_xKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:14:08 INFO - Running setup.py (path:/tmp/pip-zA7neG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:14:08 INFO - Running setup.py (path:/tmp/pip-Q3cTJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:14:09 INFO - Running setup.py (path:/tmp/pip-nXhdgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:14:09 INFO - Running setup.py (path:/tmp/pip-QXcG2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:14:09 INFO - Running setup.py (path:/tmp/pip-1yX4bU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:14:09 INFO - Running setup.py (path:/tmp/pip-0XGqaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:14:09 INFO - Running setup.py (path:/tmp/pip-ShSGZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:14:09 INFO - Running setup.py (path:/tmp/pip-uyTOIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:14:09 INFO - Running setup.py (path:/tmp/pip-RhAhst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:14:09 INFO - Running setup.py (path:/tmp/pip-5XCP3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:14:09 INFO - Running setup.py (path:/tmp/pip-pxhoNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:14:09 INFO - Running setup.py (path:/tmp/pip-0e_RxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:14:09 INFO - Running setup.py (path:/tmp/pip-UvCCwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:09 INFO - Running setup.py (path:/tmp/pip-hVLboR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:14:09 INFO - Running setup.py (path:/tmp/pip-DJmkq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:14:09 INFO - Running setup.py (path:/tmp/pip-KOGWDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:14:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:14:10 INFO - Running setup.py install for manifestparser 01:14:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:14:10 INFO - Running setup.py install for mozcrash 01:14:10 INFO - Running setup.py install for mozdebug 01:14:10 INFO - Running setup.py install for mozdevice 01:14:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:14:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:14:10 INFO - Running setup.py install for mozfile 01:14:10 INFO - Running setup.py install for mozhttpd 01:14:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:14:10 INFO - Running setup.py install for mozinfo 01:14:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:14:10 INFO - Running setup.py install for mozInstall 01:14:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:14:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:14:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:14:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:14:10 INFO - Running setup.py install for mozleak 01:14:10 INFO - Running setup.py install for mozlog 01:14:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:14:11 INFO - Running setup.py install for moznetwork 01:14:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:14:11 INFO - Running setup.py install for mozprocess 01:14:11 INFO - Running setup.py install for mozprofile 01:14:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:14:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:14:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:14:11 INFO - Running setup.py install for mozrunner 01:14:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:14:11 INFO - Running setup.py install for mozscreenshot 01:14:11 INFO - Running setup.py install for moztest 01:14:11 INFO - Running setup.py install for mozversion 01:14:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:14:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:14:11 INFO - Cleaning up... 01:14:11 INFO - Return code: 0 01:14:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:14:11 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')]} 01:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:11 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')]} 01:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:11 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 0x7f8083428e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dafc0>, '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 0x16dbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc350>, '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': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', '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 01:14:11 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 01:14:11 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 01:14:11 INFO - Using env: {'DISPLAY': ':0', 01:14:11 INFO - 'HOME': '/home/cltbld', 01:14:11 INFO - 'LANG': 'en_US.UTF-8', 01:14:11 INFO - 'LANGUAGE': 'en_US:en', 01:14:11 INFO - 'LOGNAME': 'cltbld', 01:14:11 INFO - 'MAIL': '/var/mail/cltbld', 01:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:11 INFO - 'MOZ_NO_REMOTE': '1', 01:14:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:11 INFO - 'NO_EM_RESTART': '1', 01:14:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:11 INFO - 'PWD': '/builds/slave/test', 01:14:11 INFO - 'SHELL': '/bin/bash', 01:14:11 INFO - 'SHLVL': '1', 01:14:11 INFO - 'TERM': 'linux', 01:14:11 INFO - 'TMOUT': '86400', 01:14:11 INFO - 'USER': 'cltbld', 01:14:11 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', 01:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:11 INFO - '_': '/tools/buildbot/bin/python'} 01:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:14:12 INFO - Running setup.py (path:/tmp/pip-_7KDku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:14:12 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)) 01:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:14:12 INFO - Running setup.py (path:/tmp/pip-tj9keZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:14:12 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)) 01:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:14:12 INFO - Running setup.py (path:/tmp/pip-IJ1HUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:14:12 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)) 01:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:14:12 INFO - Running setup.py (path:/tmp/pip-oJzEDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 01:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:14:12 INFO - Running setup.py (path:/tmp/pip-Fw0h9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:14:12 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)) 01:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:14:12 INFO - Running setup.py (path:/tmp/pip-WLYiYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:14:12 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)) 01:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:14:12 INFO - Running setup.py (path:/tmp/pip-Vuvzgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:14:12 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)) 01:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:14:12 INFO - Running setup.py (path:/tmp/pip-LOVO9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:14:12 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)) 01:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:14:12 INFO - Running setup.py (path:/tmp/pip-tfZC63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:14:12 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)) 01:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:14:12 INFO - Running setup.py (path:/tmp/pip-9kxKcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:14:12 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)) 01:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:14:12 INFO - Running setup.py (path:/tmp/pip-m1DDoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:14:12 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)) 01:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:14:12 INFO - Running setup.py (path:/tmp/pip-n0kQy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:14:12 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)) 01:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:14:12 INFO - Running setup.py (path:/tmp/pip-XN4bvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:14:13 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)) 01:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:14:13 INFO - Running setup.py (path:/tmp/pip-KnGILX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:14:13 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)) 01:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:13 INFO - Running setup.py (path:/tmp/pip-Klthoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:13 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)) 01:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:14:13 INFO - Running setup.py (path:/tmp/pip-veZBKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:14:13 INFO - Running setup.py (path:/tmp/pip-_tgU5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:14:13 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)) 01:14:13 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)) 01:14:13 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)) 01:14:13 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)) 01:14:13 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:14:13 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:14:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:14:13 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 01:14:13 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 01:14:13 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 01:14:13 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 01:14:13 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 01:14:13 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 01:14:15 INFO - Downloading blessings-1.6.tar.gz 01:14:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:14:15 INFO - Installing collected packages: blessings 01:14:15 INFO - Running setup.py install for blessings 01:14:15 INFO - Successfully installed blessings 01:14:15 INFO - Cleaning up... 01:14:15 INFO - Return code: 0 01:14:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:14:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:14:15 INFO - Reading from file tmpfile_stdout 01:14:15 INFO - Current package versions: 01:14:15 INFO - argparse == 1.2.1 01:14:15 INFO - blessings == 1.6 01:14:15 INFO - blobuploader == 1.2.4 01:14:15 INFO - docopt == 0.6.1 01:14:15 INFO - functools32 == 3.2.3-2 01:14:15 INFO - jsonschema == 2.5.1 01:14:15 INFO - manifestparser == 1.1 01:14:15 INFO - mozInstall == 1.12 01:14:15 INFO - mozcrash == 1.0 01:14:15 INFO - mozdebug == 0.1 01:14:15 INFO - mozdevice == 0.49 01:14:15 INFO - mozfile == 1.2 01:14:15 INFO - mozhttpd == 0.7 01:14:15 INFO - mozinfo == 0.9 01:14:15 INFO - mozleak == 0.1 01:14:15 INFO - mozlog == 3.4 01:14:15 INFO - moznetwork == 0.27 01:14:15 INFO - mozprocess == 0.23 01:14:15 INFO - mozprofile == 0.28 01:14:15 INFO - mozrunner == 6.13 01:14:15 INFO - mozscreenshot == 0.1 01:14:15 INFO - mozsystemmonitor == 0.3 01:14:15 INFO - moztest == 0.7 01:14:15 INFO - mozversion == 1.4 01:14:15 INFO - psutil == 3.1.1 01:14:15 INFO - requests == 1.2.3 01:14:15 INFO - wsgiref == 0.1.2 01:14:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:14:15 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')]} 01:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:15 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')]} 01:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:15 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 0x7f8083428e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dafc0>, '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 0x16dbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc350>, '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': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', '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 01:14:15 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 01:14:15 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 01:14:15 INFO - Using env: {'DISPLAY': ':0', 01:14:15 INFO - 'HOME': '/home/cltbld', 01:14:15 INFO - 'LANG': 'en_US.UTF-8', 01:14:15 INFO - 'LANGUAGE': 'en_US:en', 01:14:15 INFO - 'LOGNAME': 'cltbld', 01:14:15 INFO - 'MAIL': '/var/mail/cltbld', 01:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:15 INFO - 'MOZ_NO_REMOTE': '1', 01:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:15 INFO - 'NO_EM_RESTART': '1', 01:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:15 INFO - 'PWD': '/builds/slave/test', 01:14:15 INFO - 'SHELL': '/bin/bash', 01:14:15 INFO - 'SHLVL': '1', 01:14:15 INFO - 'TERM': 'linux', 01:14:15 INFO - 'TMOUT': '86400', 01:14:15 INFO - 'USER': 'cltbld', 01:14:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', 01:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:15 INFO - '_': '/tools/buildbot/bin/python'} 01:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:15 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)) 01:14:15 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)) 01:14:15 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)) 01:14:15 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)) 01:14:15 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)) 01:14:15 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)) 01:14:15 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)) 01:14:15 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)) 01:14:15 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)) 01:14:15 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)) 01:14:15 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)) 01:14:15 INFO - Cleaning up... 01:14:15 INFO - Return code: 0 01:14:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:14:15 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')]} 01:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:15 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')]} 01:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:15 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 0x7f8083428e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16dafc0>, '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 0x16dbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc350>, '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': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', '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 01:14:15 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 01:14:15 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 01:14:15 INFO - Using env: {'DISPLAY': ':0', 01:14:15 INFO - 'HOME': '/home/cltbld', 01:14:15 INFO - 'LANG': 'en_US.UTF-8', 01:14:15 INFO - 'LANGUAGE': 'en_US:en', 01:14:15 INFO - 'LOGNAME': 'cltbld', 01:14:15 INFO - 'MAIL': '/var/mail/cltbld', 01:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:15 INFO - 'MOZ_NO_REMOTE': '1', 01:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:15 INFO - 'NO_EM_RESTART': '1', 01:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:15 INFO - 'PWD': '/builds/slave/test', 01:14:15 INFO - 'SHELL': '/bin/bash', 01:14:15 INFO - 'SHLVL': '1', 01:14:15 INFO - 'TERM': 'linux', 01:14:15 INFO - 'TMOUT': '86400', 01:14:15 INFO - 'USER': 'cltbld', 01:14:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', 01:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:15 INFO - '_': '/tools/buildbot/bin/python'} 01:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:14:16 INFO - Cleaning up... 01:14:16 INFO - Return code: 0 01:14:16 INFO - Running post-action listener: _resource_record_post_action 01:14:16 INFO - Running post-action listener: _start_resource_monitoring 01:14:16 INFO - Starting resource monitoring. 01:14:16 INFO - [mozharness: 2016-11-26 09:14:16.203244Z] Finished create-virtualenv step (success) 01:14:16 INFO - [mozharness: 2016-11-26 09:14:16.203765Z] Running install step. 01:14:16 INFO - Running pre-action listener: _resource_record_pre_action 01:14:16 INFO - Running main action method: install 01:14:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:14:16 INFO - Reading from file tmpfile_stdout 01:14:16 INFO - Detecting whether we're running mozinstall >=1.0... 01:14:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:14:16 INFO - Reading from file tmpfile_stdout 01:14:16 INFO - Output received: 01:14:16 INFO - Usage: mozinstall [options] installer 01:14:16 INFO - Options: 01:14:16 INFO - -h, --help show this help message and exit 01:14:16 INFO - -d DEST, --destination=DEST 01:14:16 INFO - Directory to install application into. [default: 01:14:16 INFO - "/builds/slave/test"] 01:14:16 INFO - --app=APP Application being installed. [default: firefox] 01:14:16 INFO - mkdir: /builds/slave/test/build/application 01:14:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:14:33 INFO - Reading from file tmpfile_stdout 01:14:33 INFO - Output received: 01:14:33 INFO - /builds/slave/test/build/application/firefox/firefox 01:14:33 INFO - Running post-action listener: _resource_record_post_action 01:14:33 INFO - [mozharness: 2016-11-26 09:14:33.463881Z] Finished install step (success) 01:14:33 INFO - [mozharness: 2016-11-26 09:14:33.464120Z] Running run-tests step. 01:14:33 INFO - Running pre-action listener: _resource_record_pre_action 01:14:33 INFO - Running main action method: run_tests 01:14:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:14:33 INFO - Python 2.7.3 01:14:33 INFO - Return code: 0 01:14:33 INFO - grabbing minidump binary from tooltool 01:14:33 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')]} 01:14:33 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 0x16dafc0>, '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 0x16dbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:14:33 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 01:14:33 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 01:14:33 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 01:14:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:14:33 INFO - Return code: 0 01:14:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:14:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:14:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:14:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:14:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:14:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:14:33 INFO - Using env: {'DISPLAY': ':0', 01:14:33 INFO - 'HOME': '/home/cltbld', 01:14:33 INFO - 'LANG': 'en_US.UTF-8', 01:14:33 INFO - 'LANGUAGE': 'en_US:en', 01:14:33 INFO - 'LOGNAME': 'cltbld', 01:14:33 INFO - 'MAIL': '/var/mail/cltbld', 01:14:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:14:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:33 INFO - 'MOZ_NO_REMOTE': '1', 01:14:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:33 INFO - 'NO_EM_RESTART': '1', 01:14:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:33 INFO - 'PWD': '/builds/slave/test', 01:14:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:14:33 INFO - 'SHELL': '/bin/bash', 01:14:33 INFO - 'SHLVL': '1', 01:14:33 INFO - 'TERM': 'linux', 01:14:33 INFO - 'TMOUT': '86400', 01:14:33 INFO - 'USER': 'cltbld', 01:14:33 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709', 01:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:33 INFO - '_': '/tools/buildbot/bin/python'} 01:14:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:14:33 INFO - mozversion application_buildid: 20161125223004 01:14:33 INFO - mozversion application_changeset: f8f4eaac1701107f794b48891bcca2c95d39d503 01:14:33 INFO - mozversion application_display_name: Nightly 01:14:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:14:33 INFO - mozversion application_name: Firefox 01:14:33 INFO - mozversion application_remotingname: firefox 01:14:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:14:33 INFO - mozversion application_vendor: Mozilla 01:14:33 INFO - mozversion application_version: 53.0a1 01:14:33 INFO - mozversion platform_buildid: 20161125223004 01:14:33 INFO - mozversion platform_changeset: f8f4eaac1701107f794b48891bcca2c95d39d503 01:14:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:14:33 INFO - mozversion platform_version: 53.0a1 01:14:33 INFO - using testdate: 1480151673 01:14:33 INFO - actual date: 1480151673 01:14:33 INFO - starting webserver on 'localhost:52803' 01:14:33 INFO - SUITE-START | Running 2 tests 01:14:33 INFO - TEST-START | dromaeo_css 01:14:33 INFO - operating with platform_type : linux_ 01:14:33 INFO - Initialising browser for dromaeo_css test... 01:14:33 INFO - TEST-INFO | started process 5457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2OuIJ4/profile http://localhost:52803/getInfo.html) 01:14:38 INFO - PROCESS | 5457 | __metrics Screen width/height:1600/1200 01:14:38 INFO - PROCESS | 5457 | colorDepth:24 01:14:38 INFO - PROCESS | 5457 | Browser inner width/height: 1024/697 01:14:38 INFO - PROCESS | 5457 | __metrics 01:14:38 ERROR - PROCESS | 5457 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 01:14:39 INFO - TEST-INFO | 5457: exit 0 01:14:39 INFO - Browser initialized. 01:14:39 INFO - Running cycle 1/1 for dromaeo_css test... 01:14:39 INFO - TEST-INFO | started process 5581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2OuIJ4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:14:51 INFO - PROCESS | 5581 | RSS: Main: 186138624 01:14:51 INFO - PROCESS | 5581 | 01:15:41 INFO - PROCESS | 5581 | 1480151741525 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:17:52 INFO - PROCESS | 5581 | Cycle 1(1): loaded http://localhost:52803/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52803/tests/dromaeo/cssquery-ext.html) 01:17:54 INFO - PROCESS | 5581 | RSS: Main: 198438912 01:17:54 INFO - PROCESS | 5581 | 01:20:56 INFO - PROCESS | 5581 | Cycle 1(1): loaded http://localhost:52803/tests/dromaeo/cssquery-ext.html (next: http://localhost:52803/tests/dromaeo/cssquery-jquery.html) 01:20:57 INFO - PROCESS | 5581 | RSS: Main: 199798784 01:20:57 INFO - PROCESS | 5581 | 01:23:59 INFO - PROCESS | 5581 | Cycle 1(1): loaded http://localhost:52803/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52803/tests/dromaeo/cssquery-mootools.html) 01:23:59 INFO - PROCESS | 5581 | RSS: Main: 201617408 01:23:59 INFO - PROCESS | 5581 | 01:27:01 INFO - PROCESS | 5581 | Cycle 1(1): loaded http://localhost:52803/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52803/tests/dromaeo/cssquery-prototype.html) 01:27:02 INFO - PROCESS | 5581 | RSS: Main: 198119424 01:27:02 INFO - PROCESS | 5581 | 01:30:05 INFO - PROCESS | 5581 | Cycle 1(1): loaded http://localhost:52803/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52803/tests/dromaeo/cssquery-yui.html) 01:30:05 INFO - PROCESS | 5581 | RSS: Main: 202063872 01:30:05 INFO - PROCESS | 5581 | 01:33:08 INFO - PROCESS | 5581 | Cycle 1(1): loaded http://localhost:52803/tests/dromaeo/cssquery-yui.html (next: http://localhost:52803/tests/dromaeo/cssquery-dojo.html) 01:33:09 INFO - PROCESS | 5581 | RSS: Main: 202072064 01:33:09 INFO - PROCESS | 5581 | 01:33:09 INFO - PROCESS | 5581 | __start_tp_report 01:33:09 INFO - PROCESS | 5581 | _x_x_mozilla_page_load 01:33:09 INFO - PROCESS | 5581 | _x_x_mozilla_page_load_details 01:33:09 INFO - PROCESS | 5581 | |i|pagename|runs| 01:33:09 INFO - PROCESS | 5581 | |0;dojo.html;3205.615326160861;3211.7270032047277;3221.4845624700038;3256.4789633658606;3262.6411094779555;5374.811881584145;5622.746976386063;5633.746481408336;5633.8309850704445;5691.402402747714;5387.622866399353;5538.806141785039;5606.579506537016;5637.689927054011;5682.6306290091115;4973.4280557735965;4998.075356059141;5020.774065167058;5110.667806592578;5115.641905066647;4616.584507394334;4907.730074845882;5074.949250507503;5168.689878607295;5171.767270472819;4858.684185527929;5127.051495473349;5164.173732202848;5183.844484665466;5199.818006369778;4895.853124406273;4929.852104436873;4938.283948827436;4995.925061124086;5036.269740887551;4965.205567109281;5015.6238282128625;5070.569001634865;5076.720780357079;5095.082885080684;5511;5521.834344969617;5606.719664016783;5610.915836262459;5660.377358490563;5757.68332741699;5849.064149736065;6008.429199226067;6035.486983606354;6043.335233124353;5964.433378829004;5973.342932277489;5976.9402305977255;5979.133025711291;5980.491658209014;5511.889762204773;5536.058869992111;5548.6948217848;5560.610757246954;5580.63725857822;6133.417325354084;6133.4264757247465;6186.566940314135;6199.039148931923;6207.34822843604;5970.77599092185;5971.104334349882;5974.372690867396;5978.55160862937;6010.939890601126;5745.511631511368;5804.506616937608;6047.78832740852;6060;6061.8484537886025;5767.625104368202;5858.443447872445;5937.762489500372;5947.851303717442;6057.757689692363;5950.8809823803285;6010.429009244115;6013.368596297413;6019.548533859978;6029.728662210211;4555.407796986437;4573.108243892476;4582.358469814229;4589.10512450069;4627.699199552018;3927.6072392761066;3961.2869683457257;3971.801409929492;3975.4036894465485;3980.9203815924097;5659;5670.376258611549;5670.688112153871;5677.687727174963;5711.885762284731;5982.670953097621;5986.940130598726;5988.700564971734;6001.12983617373;6025.0661147522205;5445.50990410865;5453.400125986138;5457.481539253765;5539.335279766454;5672.744726487318;4934.802607895644;4944.060628480577;4948.4309304429735;4962.15643340633;4966.627502937295;6097.373446762125;6101.206843110367;6116.396640261158;6147.262328520606;6167.814965551041;5978.581499295007;5981.162637230878;5990.2212712348855;6004.489618382312;6031.969840150771;5832.3292821326095;5909.349971503218;6043.123747056564;6129.877402451837;6162.352952939877;5697.401772813795;5700.059490184073;5702.258706368311;5712.571557133148;5713.342965559014;5793.478586927196;5949.91075133882;5974.551908606785;5996.220491336098;6046.637201767908;5823.82528524145;5850.297964244318;5861.736221869941;5863.120531920075;5883.676397798162;5847.064469685;5853.268341457318;5862.062070068769;5875.970620146872;5891.23413956183;5580.330360356621;5612.130119831432;5624.268845050117;5632.633878797865;5710.172025056427;5836.649801011953;5911.55663325261;5933.1396947443245;5946.13781001761;5947.821565353046;5727.398623144676;5762.510186634183;5775.047117225611;5780.393058728773;5806.622569532967 01:33:09 INFO - PROCESS | 5581 | |1;ext.html;557.6988426249825;604.2959951656319;608.7352001879183;616.3620652624535;653.0563335979506;37545.249095018116;40729;41210.38184427232;41237;41363.58636413635;41252.79373603135;41982;42089.78955105228;42098.36852447216;42208.15583688324;8316.792080197998;8559.22966932976;8560.272376847975;8575.485470871736;10121.291509594332;9997.900230974587;10329.63846265381;10329.741756456073;10333.741656458611;10338.379697218192;10315.845262321034;10325.483725813718;10339.896601034006;10362.067413932744;10415.791684166312;10279.897201028043;10333.225008124384;10367.688969330931;10377.533011014522;10384.221183411275;10209.795804083951;10306.536205870754;10332.94833525835;10333.328333658288;10340.896591034068;41169.382459263135;41558.584414155775;41559;41564.376534352006;41567.792161039004;3564.4475106358555;3645.5078564393734;3741.0834345585235;3823.4264860270905;3979.602039796026;30267.69732302693;30912;30919.381612367626;31017.534736978963;32014.679853201636;4056.14820887611;4178.749275043507;4185.748855068706;4313.698041137121;4346.15250026245;342998;343142;343626;344100;344625.27687361656;59794.40205597975;59821.40178598245;60007;60228.39771602316;60281;61660;62125.37874621286;62340;62528.374716252256;62616.37383626196;16289.429869954494;16477;16599;16618.169091545373;16677.166141692865;11888.405579720978;12172.878271217174;13137.540186093442;13216.537421190404;13370.197788132744;18486.042233242617;19179.80820191808;19357.83442007486;19425.212083643837;19443.8055619442;6894.931050689529;7042.718291268292;7284.490085694057;7334.816629584197;7494.70021199146;948.691675205561;1008.7679833638305;1015.8064274477607;1080.8000519903685;1103.586155191787;31881;32396.190095247806;32429;32453;32909.83545082307;1051.1695760349392;1108.257467496763;1110.4225802582612;1119.4738472917716;1123.3709122891207;15508.5347439577;16934.40729574459;16992.660146796996;17078.316867325168;17108;486923;491205;491705;492922;493260;57002.714986424806;57274.42725572774;57572.71213643905;57612;57739.422605773405;1302.0820321673198;1326.8142460055599;1328.8206092177431;1342.8992825538123;1358.0629365737807;30433;31316.782839681095;31778.205544861565;31867.36265274728;32505;51468.74265628648;51522.74238628783;51686;51776;51780.741096294274;434846;436574;441713;442287;442628;35793.284134316644;41443.1711365777;41757;42469.787651061546;42779.786101069294;44495.777521112184;46079.76960115178;46564.53435465602;46869.2969605463;47760;38908;40251.59748402596;40744.18511629692;41329.793351033055;42234.36648450214;39801.60198397979;40046;40876.59123408728;41099;41492.170156597305;40096.59903400928;40210.19579608333;40350;40423.79788101158;40484.79757601193;33508;35254.53554699026;36090.27819443649;36222.275554489286;36691.81654091713;27525.17424477269;27621.585676215276;27780.44439111166;27943.301417463914;27984.362032935587 01:33:09 INFO - PROCESS | 5581 | |2;jquery.html;382.55241367599905;388.9824957876895;394.6448196623039;398.4004073868827;426.5478592691747;17489.300427982882;18856.34002809902;18865;19011.904940475313;19591.90204048978;18495.537611559717;18643.29672197534;19220.903895480504;19299.13153908074;19308.455323574115;5570.972145139279;5587.720613969305;5729.1119876419225;5767.192593036978;5829.708514574254;5633.436656334375;5752.395998420168;5753.194552762617;5753.827385178452;5754.568407369443;5505.284313039299;5630.183623374608;5650.943490565083;5691.857703557403;5701.77192912283;5665.23519324892;5666.575006874501;5671.574631902624;5717.914231286534;5729;4924.6060315175055;5063.924041139386;5079.3650793650795;5097.133487307166;5110.10573149701;21979.23072692464;22079.889600552055;22122;22272.329575281758;22758.772412275997;2457.9877100614563;2501.6247562865533;2643.0842607313157;2743.43759529296;2911.4132797625343;10073.44596047217;10393.272470927039;10765.246432749711;10897.128229741602;14312.21282829444;1890.1022014542982;1922.5385907382267;1951.6194342103295;1955.501347156466;1975.585127123306;84036.99999999939;84155.5792221041;84610;87301.56349218277;88708.11291887063;9409.247260219303;9698.175655069257;9920;10061.79876402468;10124.949375253223;13423.865761342457;13441;13460.394282257126;13466.124701894345;13470.797938030937;7174.461915356369;7267.89098163528;7565.243475652391;7697.345725613385;7761.379089672925;7133.82165445868;7223.8555228896175;7407.148177959496;7465.925340746631;7497.66260518278;4153.979230103891;4181.351890456984;4217.7891105444605;4223.113146239324;4292.935605965913;1884.180381534037;2021.7169596256535;2048.9077991490417;2081.427607407975;2141.5716856628737;856.3406177243488;956.4070276428658;967.2890425537224;1016.2784423059562;1052.7631282961427;18730;19518.5120371989;19577;19663.508412289808;19761.40715778529;991.8462638291077;997.7705127820642;1039.101177481473;1065.3820783945293;1076.7146706122883;10211.336263142872;10762.515686794113;10838.837417438745;10927.289726167774;10950.671479855617;447418;467001;468897;474226;475578;61280;90271.54864225637;93043;93188.53405732928;94296.52851735834;989.7723523589615;1045.534737042009;1073.983890241647;1077.531273895842;1079.0019232210332;16631.251593678557;16684.49946501607;17006.659866802842;17428.912855435643;17514.299428023245;41128.58871411248;41238;41666.37500437435;42140;42858.35712464378;55032.44967550434;56368.43631563632;56471;57104.42895570991;57220.71389643025;8081.232282933112;8290.544020078712;8658;8715.782105447415;8873.467591944504;9495.477748723886;12200.145989780985;12587.307698076695;12592;12963;10967.890321096687;11186.32882027081;11235.66293011211;11501.597444089417;11683.649490515298;10555.208359372924;10645.520951557353;11048.337099774039;11304.152188586053;11371.090312774793;10802.837957430802;11346.602868899548;11429.942850285695;11461.369624670722;11522.251053681484;8151.184881511801;8424.915750842658;8640.654373824977;8705.173008564176;8825.735227943173;11287.661370158909;11296;11448.885511145116;11499.022583080532;11597.18819682614 01:33:09 INFO - PROCESS | 5581 | |3;mootools.html;1447.8334991475976;1451.1873350923483;1594.7607858821182;1730.9740353894701;1733.4799560131964;8078.868958345829;8395.202455766708;8684.47893126412;8707.608157632905;8707.869381959275;8630.741077767678;8760.912390876088;8777.561121943909;8793.736187914374;8848.51333176675;2291.0377641390614;2321.7446080931086;2326.4532834783813;2326.7440581536016;2332.6384410416413;2333.230034088747;2364.326167042393;2384.9642255366184;2387.3673476528734;2387.689600351952;2282.9771702283015;2290.7251129864358;2294.5640328337645;2308.249818808894;2308.6421604651223;2222.29997550771;2241.3500084975417;2270.0919632147275;2273.545290941818;2275.0444813178424;2293.5068960173644;2301.1255722825385;2312.5374925014894;2313.4794671198847;2313.652952057188;8221.342292616577;8361;8412.663493460253;8415.621297041587;8475.703350382768;5188.948110518922;5225.895482090337;5323.760430780624;5337.70642614656;5346.117890548055;3064.5096784514594;3119.2825650100376;3372.9494057589154;3377.392069427502;3397.69420752131;1195.3365881935522;1195.545692636801;2011.185469884699;2014.7280117184287;2050.846186536001;11714.355710435922;11749.4712737927;11800.881991180064;11874.16880818343;11879.703007424798;4299.527052024275;4445.688801783844;4562.5665561771575;4634.235351167087;4652.813887444532;9079.773005674911;9113.908860911439;9116.817663646823;9124.498152601538;9141.31440141992;5075.5178258065425;5083.186690129562;5084.13569693153;5087.186050232019;5093.439721630618;4733.810647574059;4752.1921273383605;4895.265710143507;4947.727874966839;5017.347744793226;3798.4302354647025;3803.4484999675446;3846.211526637033;3870.148567315186;3981.1241526864624;1209.1777591238042;1216.7019080325376;1229.8093795461539;1231.6982339326921;1233.112159245342;803.3292201012221;949.0793929887998;957.2724729205854;966.0580933589835;969.680005598151;5512.751926163332;5705.828825135252;5863.179154918314;5906.877693238271;5982.192404025401;448.91695036418366;455.8176729308237;455.9977200113978;459.0612198054919;465.7834107140196;3730.925381492355;3863.517060367454;3925.9018524537114;3927.7446965947124;4065.1869626074904;10096.848547271797;10400.890535069919;10481.213908956859;10560.049595536439;10589.205809564313;10417.42704151279;10483.423411712429;10517.580126682953;10532.842007369742;10679.83980240297;7790.065192176975;7856.450048496665;7884.172161922916;7917.0895347034675;7980.526036928571;5547.389787123332;5577.776888924398;5641.774329026793;5664.830055098354;5872.148538461814;9517.619295228391;9585.808283834145;9635.084666956627;9662.3236373456;9746.366486178376;9615.951920240354;9651.324407291422;9656.420614763138;9744.75638109053;9756.951215243878;6340.71466784005;6542.509311801538;6842;7034.788956331318;7103.644817759195;8063.677452902053;8382.580870956306;8385.32917366597;8389.538575378412;8398.076211616595;7053.4004609608755;7127.2516385778745;7201.783946481614;7245.927540724525;7441.516301440389;7158.4273258140265;7254.129504459499;7420.6289685516585;7476.850462990601;7549.50928189666;6597.888675623946;6746.257911629618;6761.019652150509;6767.93232067673;6775.796726098225;4906.607471402208;4998.925016124688;5055.292259083658;5060.671056381323;5120.667156634807;5046.066477701637;5054.747262636927;5067.695938243717;5162.741862906914;5173.22401639757 01:33:09 INFO - PROCESS | 5581 | |4;prototype.html;329.2920221523724;342.1736506337196;351.74147001953577;353.1453881606512;356.6647351489601;5360.437154098812;5452.418798548416;5515.31782806244;5553.916691249629;5587.8603034924145;5324.92012619811;5458.372287186965;5478.835634930959;5485.61600687952;5502.174673798932;4330.917270682329;4369.759663218521;4370.562943705636;4375.4311939447825;4388.2978723404185;4266.445362102922;4303.784810759449;4304.870853874389;4360.171567402199;4413.88965275869;4263;4274.8244232835905;4288.506821715511;4292.720973136752;4297.39836422901;4271.487421509408;4295.183915056129;4297.8495752648505;4302.548232435596;4314.158739045887;3851.094992676719;3859.8649047283493;3862.613738626115;3879.9612003879884;3882.223555288925;5124.666896651705;5283.471652834724;5347.812826551091;5382.865428364283;5390.789776191782;4977.701337919736;4980.427250866161;4993.575546078588;5033.874153146164;5041.924371134399;5603.859903502404;5705.286839145107;5729.398413166599;5750.683712395817;5767.221425107598;4220.261454245495;4221.894452638678;4225.415469199051;4235.53409124996;4261.126469073833;5962.522998160137;5977.282726072855;5996.550258730569;5999.310079340845;6027.246594175772;4288.807003684841;4328.718633288826;4383.627391671744;4395.780210989502;4402.977985110054;4363.759993200341;4404.3263559847055;4419.64642828573;4424;4425.601695847389;4970;4971.980743947482;4995.575376093;4997.90004199914;5005.274235235943;5694.259746232963;5771.192033115367;5781;5798.911767204111;5801.593888427769;1465.5198249767598;1476.497990683173;1479.844616315293;1489.6722721001363;1493.7087267982856;1016.5462294788407;1033.9741506462399;1043.0977204717865;1043.598214687351;1055.2033214922685;5332.253484512172;5365.839024829262;5374.865628359323;5398.4871437213405;5404.648697834707;5718.51392631631;5770.480656740913;5778.3531693468;5783.248177736868;5819.0689489681445;5254.264402983586;5471.671699698031;5475.6181061238485;5657.57568182388;5658.91511627326;3047.238190452387;3058.98470507646;3066.7546596272246;3069.6210436911574;3107.9533806992913;5706.771729130788;5942;5958.910616340759;5974.2233509643465;5986.431289027535;5792.395045938405;5807.332156801937;5833.533317334603;5846.473817356458;5862.8534286642325;5926.525877929756;5959.791407300723;5974.924513587509;5983.311919129356;5984.611000285055;5556.499915007668;5601.831945041656;5700.629459085146;5713.914421236136;5732.671832766235;5638.23883775685;5699.230603868425;5708.343540492897;5721.685307308138;5747.942520574908;5617.185508101221;5886.381929897299;5921.14143449206;5932.288125424977;5947.851303717442;4024.2756303865585;4034.7377420467574;4145.647619952338;4159.1681663668;4177.937330940099;5875.764969401347;5895;5957.106434034929;5972.970135149297;5979.342272350125;5587.776488940397;5725.570582206435;5733.971330143323;5751.396103409082;5796.739146738491;5701.287339082614;5736.99602569557;5737.6557406554075;5740.741666624928;5741.655500669973;5709.771609135754;5714.657120572779;5728;5747.252857128547;5798.884022319446;5585.273914391103;5735.311762588349;5765.654060756368;5770.249867517364;5815.5929084963645;5656.208130861601;5656.43435656431;5663.1788390682295;5687.374388817309;5689.715514224189 01:33:09 INFO - PROCESS | 5581 | |5;yui.html;704.2288693880201;730.4813582356527;760.9657565409556;774.4191856107917;776.3168411797617;14215.71568568628;15186.088834669927;15355.923220383882;15371.231438428076;15374.385024599003;13683.589492315246;13799.931000344985;13801.447942082305;13830.23933683647;13849;652.797632733854;676.1649363036646;752.1726101288566;771.961401929904;778.5834578500503;776.4487214077983;788.1330536409961;788.5229436191108;789.0767801672029;790.0913948958686;811.111832543367;817.8609636361803;819.72948926854;820.6102101501799;825.3727167352826;813.6297984417076;813.9308158806508;814.5764202614607;815.787895147263;817.5217497763815;605.0138274612398;605.5186127028978;605.8152263559613;606.7087797857009;606.7178761875749;13802;13962.790558141636;13968.301584920713;13970.231637259947;14014.509492167725;13114;13596.38816253261;13890.722185556333;13968.231747253896;14164.36260368286;10761.569537218502;11040.723981900437;11076.944615276952;11180.105591552656;11263.718407039807;3526.400511912981;3538.5046093546925;3603.8738644147593;3672;3710.7588006779474;62290;62600;63323;63620.68189659022;64136.03795943064;10509.632162874415;10606.098481628993;10637.521311540999;10647.467626618638;11049.668509944715;17627.55931101733;17678.911605442147;17781.555461113574;17784;17794.199261033285;7672.578008209602;7706;7778.961105194438;7816.570088645065;7855.960720196363;4336.82652693895;4464.330350447459;4518.593326600556;4519.932201016987;4528.275475923902;3523.9295214095573;3574.8748793792092;3576.9284614307567;3606.1705807664384;3626.6192049834917;602.6384169498266;616.8026231605843;618.9071639254148;621.3475850357107;629.7166275176189;697.7767114523303;699.5173330402006;713.846522997558;715.2561336210387;717.1322699533623;9509.5720692569;9622.566984485715;9887.752806179904;9999.400095984753;10103.494825258707;618.9288231853304;648.7275344355382;695.3672158335991;697.7348607529107;697.8150790040643;4358.2240311344685;4369.453818272716;4602.6774135626065;4776.331313616097;4827.8551643450755;49491.05089491022;50625.24062139071;74028;77079.2292077072;79562.60218698869;45799.09358035772;56625.43374566284;58687;73621;74849;62534.374656252854;63508.3649163521;64150;65607.67196163989;65862;8402.579871006303;8610.913890861011;8702.347323950855;8726.82546349082;8878.200961913459;42551.31935487156;42832.357514636686;43571;44563;44924.326135108655;58582;61870.38129618646;62725.763595667806;62996;63717.681411592646;11009.339439633648;11053.557857685924;11075.778484430428;11261.436928153724;11299.71750706206;12355.876441235472;12515.374231288217;12559.87440125587;12833.230006199658;13228.338583071001;11309.223103820603;11645.301281923112;11646.708832278922;11750.23623464472;12055;11551.653450396501;11626.709332266422;11912.702182445508;11936.820947685965;11937.343446110548;11240;11360.204785664924;11523.156463665235;11897.940510297392;12163.939180304042;10649.680509584725;10881.891181088404;10955.890441095487;11320.433978300887;11599.072074233873;11087.833682494931;11145.442727863412;11379.317240965569;11473.737888832055;11530.135239857213 01:33:09 INFO - PROCESS | 5581 | __end_tp_report 01:33:09 INFO - PROCESS | 5581 | __start_cc_report 01:33:09 INFO - PROCESS | 5581 | _x_x_mozilla_cycle_collect,327 01:33:09 INFO - PROCESS | 5581 | __end_cc_report 01:33:09 INFO - PROCESS | 5581 | __startTimestamp1480152789072__endTimestamp 01:33:09 INFO - PROCESS | 5581 | 01:33:09 INFO - PROCESS | 5581 | ------- Summary: start ------- 01:33:09 INFO - PROCESS | 5581 | Number of tests: 6 01:33:09 INFO - PROCESS | 5581 | 01:33:09 INFO - PROCESS | 5581 | [#0] dojo.html Cycles:165 Average:5518.77 Median:5711.89 stddev:644.76 (11.3%) stddev-sans-first:620.68 01:33:09 INFO - PROCESS | 5581 | Values: 3205.6 3211.7 3221.5 3256.5 3262.6 5374.8 5622.7 5633.7 5633.8 5691.4 5387.6 5538.8 5606.6 5637.7 5682.6 4973.4 4998.1 5020.8 5110.7 5115.6 4616.6 4907.7 5074.9 5168.7 5171.8 4858.7 5127.1 5164.2 5183.8 5199.8 4895.9 4929.9 4938.3 4995.9 5036.3 4965.2 5015.6 5070.6 5076.7 5095.1 5511.0 5521.8 5606.7 5610.9 5660.4 5757.7 5849.1 6008.4 6035.5 6043.3 5964.4 5973.3 5976.9 5979.1 5980.5 5511.9 5536.1 5548.7 5560.6 5580.6 6133.4 6133.4 6186.6 6199.0 6207.3 5970.8 5971.1 5974.4 5978.6 6010.9 5745.5 5804.5 6047.8 6060.0 6061.8 5767.6 5858.4 5937.8 5947.9 6057.8 5950.9 6010.4 6013.4 6019.5 6029.7 4555.4 4573.1 4582.4 4589.1 4627.7 3927.6 3961.3 3971.8 3975.4 3980.9 5659.0 5670.4 5670.7 5677.7 5711.9 5982.7 5986.9 5988.7 6001.1 6025.1 5445.5 5453.4 5457.5 5539.3 5672.7 4934.8 4944.1 4948.4 4962.2 4966.6 6097.4 6101.2 6116.4 6147.3 6167.8 5978.6 5981.2 5990.2 6004.5 6032.0 5832.3 5909.3 6043.1 6129.9 6162.4 5697.4 5700.1 5702.3 5712.6 5713.3 5793.5 5949.9 5974.6 5996.2 6046.6 5823.8 5850.3 5861.7 5863.1 5883.7 5847.1 5853.3 5862.1 5876.0 5891.2 5580.3 5612.1 5624.3 5632.6 5710.2 5836.6 5911.6 5933.1 5946.1 5947.8 5727.4 5762.5 5775.0 5780.4 5806.6 01:33:09 INFO - PROCESS | 5581 | 01:33:09 INFO - PROCESS | 5581 | [#1] ext.html Cycles:180 Average:59207.31 Median:21443.80 stddev:113419.42 (528.9%) stddev-sans-first:113652.11 01:33:09 INFO - PROCESS | 5581 | Values: 557.7 604.3 608.7 616.4 653.1 37545.2 40729.0 41210.4 41237.0 41363.6 41252.8 41982.0 42089.8 42098.4 42208.2 8316.8 8559.2 8560.3 8575.5 10121.3 9997.9 10329.6 10329.7 10333.7 10338.4 10315.8 10325.5 10339.9 10362.1 10415.8 10279.9 10333.2 10367.7 10377.5 10384.2 10209.8 10306.5 10332.9 10333.3 10340.9 41169.4 41558.6 41559.0 41564.4 41567.8 3564.4 3645.5 3741.1 3823.4 3979.6 30267.7 30912.0 30919.4 31017.5 32014.7 4056.1 4178.7 4185.7 4313.7 4346.2 342998.0 343142.0 343626.0 344100.0 344625.3 59794.4 59821.4 60007.0 60228.4 60281.0 61660.0 62125.4 62340.0 62528.4 62616.4 16289.4 16477.0 16599.0 16618.2 16677.2 11888.4 12172.9 13137.5 13216.5 13370.2 18486.0 19179.8 19357.8 19425.2 19443.8 6894.9 7042.7 7284.5 7334.8 7494.7 948.7 1008.8 1015.8 1080.8 1103.6 31881.0 32396.2 32429.0 32453.0 32909.8 1051.2 1108.3 1110.4 1119.5 1123.4 15508.5 16934.4 16992.7 17078.3 17108.0 486923.0 491205.0 491705.0 492922.0 493260.0 57002.7 57274.4 57572.7 57612.0 57739.4 1302.1 1326.8 1328.8 1342.9 1358.1 30433.0 31316.8 31778.2 31867.4 32505.0 51468.7 51522.7 51686.0 51776.0 51780.7 434846.0 436574.0 441713.0 442287.0 442628.0 35793.3 41443.2 41757.0 42469.8 42779.8 44495.8 46079.8 46564.5 46869.3 47760.0 38908.0 40251.6 40744.2 41329.8 42234.4 39801.6 40046.0 40876.6 41099.0 41492.2 40096.6 40210.2 40350.0 40423.8 40484.8 33508.0 35254.5 36090.3 36222.3 36691.8 27525.2 27621.6 27780.4 27943.3 27984.4 01:33:09 INFO - PROCESS | 5581 | 01:33:09 INFO - PROCESS | 5581 | [#2] jquery.html Cycles:180 Average:28052.57 Median:385.77 stddev:77121.89 (19991.8%) stddev-sans-first:77310.25 01:33:09 INFO - PROCESS | 5581 | Values: 382.6 389.0 394.6 398.4 426.5 17489.3 18856.3 18865.0 19011.9 19591.9 18495.5 18643.3 19220.9 19299.1 19308.5 5571.0 5587.7 5729.1 5767.2 5829.7 5633.4 5752.4 5753.2 5753.8 5754.6 5505.3 5630.2 5650.9 5691.9 5701.8 5665.2 5666.6 5671.6 5717.9 5729.0 4924.6 5063.9 5079.4 5097.1 5110.1 21979.2 22079.9 22122.0 22272.3 22758.8 2458.0 2501.6 2643.1 2743.4 2911.4 10073.4 10393.3 10765.2 10897.1 14312.2 1890.1 1922.5 1951.6 1955.5 1975.6 84037.0 84155.6 84610.0 87301.6 88708.1 9409.2 9698.2 9920.0 10061.8 10124.9 13423.9 13441.0 13460.4 13466.1 13470.8 7174.5 7267.9 7565.2 7697.3 7761.4 7133.8 7223.9 7407.1 7465.9 7497.7 4154.0 4181.4 4217.8 4223.1 4292.9 1884.2 2021.7 2048.9 2081.4 2141.6 856.3 956.4 967.3 1016.3 1052.8 18730.0 19518.5 19577.0 19663.5 19761.4 991.8 997.8 1039.1 1065.4 1076.7 10211.3 10762.5 10838.8 10927.3 10950.7 447418.0 467001.0 468897.0 474226.0 475578.0 61280.0 90271.5 93043.0 93188.5 94296.5 989.8 1045.5 1074.0 1077.5 1079.0 16631.3 16684.5 17006.7 17428.9 17514.3 41128.6 41238.0 41666.4 42140.0 42858.4 55032.4 56368.4 56471.0 57104.4 57220.7 8081.2 8290.5 8658.0 8715.8 8873.5 9495.5 12200.1 12587.3 12592.0 12963.0 10967.9 11186.3 11235.7 11501.6 11683.6 10555.2 10645.5 11048.3 11304.2 11371.1 10802.8 11346.6 11429.9 11461.4 11522.3 8151.2 8424.9 8640.7 8705.2 8825.7 11287.7 11296.0 11448.9 11499.0 11597.2 01:33:09 INFO - PROCESS | 5581 | 01:33:09 INFO - PROCESS | 5581 | [#3] mootools.html Cycles:180 Average:5582.09 Median:5064.18 stddev:3109.01 (61.4%) stddev-sans-first:3102.20 01:33:09 INFO - PROCESS | 5581 | Values: 1447.8 1451.2 1594.8 1731.0 1733.5 8078.9 8395.2 8684.5 8707.6 8707.9 8630.7 8760.9 8777.6 8793.7 8848.5 2291.0 2321.7 2326.5 2326.7 2332.6 2333.2 2364.3 2385.0 2387.4 2387.7 2283.0 2290.7 2294.6 2308.2 2308.6 2222.3 2241.4 2270.1 2273.5 2275.0 2293.5 2301.1 2312.5 2313.5 2313.7 8221.3 8361.0 8412.7 8415.6 8475.7 5188.9 5225.9 5323.8 5337.7 5346.1 3064.5 3119.3 3372.9 3377.4 3397.7 1195.3 1195.5 2011.2 2014.7 2050.8 11714.4 11749.5 11800.9 11874.2 11879.7 4299.5 4445.7 4562.6 4634.2 4652.8 9079.8 9113.9 9116.8 9124.5 9141.3 5075.5 5083.2 5084.1 5087.2 5093.4 4733.8 4752.2 4895.3 4947.7 5017.3 3798.4 3803.4 3846.2 3870.1 3981.1 1209.2 1216.7 1229.8 1231.7 1233.1 803.3 949.1 957.3 966.1 969.7 5512.8 5705.8 5863.2 5906.9 5982.2 448.9 455.8 456.0 459.1 465.8 3730.9 3863.5 3925.9 3927.7 4065.2 10096.8 10400.9 10481.2 10560.0 10589.2 10417.4 10483.4 10517.6 10532.8 10679.8 7790.1 7856.5 7884.2 7917.1 7980.5 5547.4 5577.8 5641.8 5664.8 5872.1 9517.6 9585.8 9635.1 9662.3 9746.4 9616.0 9651.3 9656.4 9744.8 9757.0 6340.7 6542.5 6842.0 7034.8 7103.6 8063.7 8382.6 8385.3 8389.5 8398.1 7053.4 7127.3 7201.8 7245.9 7441.5 7158.4 7254.1 7420.6 7476.9 7549.5 6597.9 6746.3 6761.0 6767.9 6775.8 4906.6 4998.9 5055.3 5060.7 5120.7 5046.1 5054.7 5067.7 5162.7 5173.2 01:33:09 INFO - PROCESS | 5581 | 01:33:09 INFO - PROCESS | 5581 | [#4] prototype.html Cycles:180 Average:4833.96 Median:5473.64 stddev:1388.97 (25.4%) stddev-sans-first:1351.09 01:33:09 INFO - PROCESS | 5581 | Values: 329.3 342.2 351.7 353.1 356.7 5360.4 5452.4 5515.3 5553.9 5587.9 5324.9 5458.4 5478.8 5485.6 5502.2 4330.9 4369.8 4370.6 4375.4 4388.3 4266.4 4303.8 4304.9 4360.2 4413.9 4263.0 4274.8 4288.5 4292.7 4297.4 4271.5 4295.2 4297.8 4302.5 4314.2 3851.1 3859.9 3862.6 3880.0 3882.2 5124.7 5283.5 5347.8 5382.9 5390.8 4977.7 4980.4 4993.6 5033.9 5041.9 5603.9 5705.3 5729.4 5750.7 5767.2 4220.3 4221.9 4225.4 4235.5 4261.1 5962.5 5977.3 5996.6 5999.3 6027.2 4288.8 4328.7 4383.6 4395.8 4403.0 4363.8 4404.3 4419.6 4424.0 4425.6 4970.0 4972.0 4995.6 4997.9 5005.3 5694.3 5771.2 5781.0 5798.9 5801.6 1465.5 1476.5 1479.8 1489.7 1493.7 1016.5 1034.0 1043.1 1043.6 1055.2 5332.3 5365.8 5374.9 5398.5 5404.6 5718.5 5770.5 5778.4 5783.2 5819.1 5254.3 5471.7 5475.6 5657.6 5658.9 3047.2 3059.0 3066.8 3069.6 3108.0 5706.8 5942.0 5958.9 5974.2 5986.4 5792.4 5807.3 5833.5 5846.5 5862.9 5926.5 5959.8 5974.9 5983.3 5984.6 5556.5 5601.8 5700.6 5713.9 5732.7 5638.2 5699.2 5708.3 5721.7 5747.9 5617.2 5886.4 5921.1 5932.3 5947.9 4024.3 4034.7 4145.6 4159.2 4177.9 5875.8 5895.0 5957.1 5973.0 5979.3 5587.8 5725.6 5734.0 5751.4 5796.7 5701.3 5737.0 5737.7 5740.7 5741.7 5709.8 5714.7 5728.0 5747.3 5798.9 5585.3 5735.3 5765.7 5770.2 5815.6 5656.2 5656.4 5663.2 5687.4 5689.7 01:33:09 INFO - PROCESS | 5581 | 01:33:09 INFO - PROCESS | 5581 | [#5] yui.html Cycles:180 Average:16325.02 Median:4519.26 stddev:20744.29 (459.0%) stddev-sans-first:20769.32 01:33:09 INFO - PROCESS | 5581 | Values: 704.2 730.5 761.0 774.4 776.3 14215.7 15186.1 15355.9 15371.2 15374.4 13683.6 13799.9 13801.4 13830.2 13849.0 652.8 676.2 752.2 772.0 778.6 776.4 788.1 788.5 789.1 790.1 811.1 817.9 819.7 820.6 825.4 813.6 813.9 814.6 815.8 817.5 605.0 605.5 605.8 606.7 606.7 13802.0 13962.8 13968.3 13970.2 14014.5 13114.0 13596.4 13890.7 13968.2 14164.4 10761.6 11040.7 11076.9 11180.1 11263.7 3526.4 3538.5 3603.9 3672.0 3710.8 62290.0 62600.0 63323.0 63620.7 64136.0 10509.6 10606.1 10637.5 10647.5 11049.7 17627.6 17678.9 17781.6 17784.0 17794.2 7672.6 7706.0 7779.0 7816.6 7856.0 4336.8 4464.3 4518.6 4519.9 4528.3 3523.9 3574.9 3576.9 3606.2 3626.6 602.6 616.8 618.9 621.3 629.7 697.8 699.5 713.8 715.3 717.1 9509.6 9622.6 9887.8 9999.4 10103.5 618.9 648.7 695.4 697.7 697.8 4358.2 4369.5 4602.7 4776.3 4827.9 49491.1 50625.2 74028.0 77079.2 79562.6 45799.1 56625.4 58687.0 73621.0 74849.0 62534.4 63508.4 64150.0 65607.7 65862.0 8402.6 8610.9 8702.3 8726.8 8878.2 42551.3 42832.4 43571.0 44563.0 44924.3 58582.0 61870.4 62725.8 62996.0 63717.7 11009.3 11053.6 11075.8 11261.4 11299.7 12355.9 12515.4 12559.9 12833.2 13228.3 11309.2 11645.3 11646.7 11750.2 12055.0 11551.7 11626.7 11912.7 11936.8 11937.3 11240.0 11360.2 11523.2 11897.9 12163.9 10649.7 10881.9 10955.9 11320.4 11599.1 11087.8 11145.4 11379.3 11473.7 11530.1 01:33:09 INFO - PROCESS | 5581 | -------- Summary: end -------- 01:33:09 INFO - PROCESS | 5581 | 01:33:10 INFO - TEST-INFO | 5581: exit 0 01:33:10 INFO - TEST-OK | dromaeo_css | took 1116414ms 01:33:10 INFO - TEST-START | kraken 01:33:10 INFO - operating with platform_type : linux_ 01:33:10 INFO - Initialising browser for kraken test... 01:33:10 INFO - TEST-INFO | started process 5933 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmHlldn/profile http://localhost:52803/getInfo.html) 01:33:14 INFO - PROCESS | 5933 | __metrics Screen width/height:1600/1200 01:33:14 INFO - PROCESS | 5933 | colorDepth:24 01:33:14 INFO - PROCESS | 5933 | Browser inner width/height: 1024/697 01:33:14 INFO - PROCESS | 5933 | __metrics 01:33:14 ERROR - PROCESS | 5933 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 01:33:15 INFO - TEST-INFO | 5933: exit 0 01:33:15 INFO - Browser initialized. 01:33:15 INFO - Running cycle 1/1 for kraken test... 01:33:15 INFO - TEST-INFO | started process 6059 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmHlldn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:33:28 INFO - PROCESS | 6059 | RSS: Main: 186167296 01:33:28 INFO - PROCESS | 6059 | 01:33:30 INFO - PROCESS | 6059 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52803/tests/kraken/driver.html?testName=audio-beat-detection) 01:33:31 INFO - PROCESS | 6059 | RSS: Main: 194367488 01:33:31 INFO - PROCESS | 6059 | 01:33:34 INFO - PROCESS | 6059 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52803/tests/kraken/driver.html?testName=audio-dft) 01:33:35 INFO - PROCESS | 6059 | RSS: Main: 197214208 01:33:35 INFO - PROCESS | 6059 | 01:33:37 INFO - PROCESS | 6059 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52803/tests/kraken/driver.html?testName=audio-fft) 01:33:38 INFO - PROCESS | 6059 | RSS: Main: 193093632 01:33:38 INFO - PROCESS | 6059 | 01:33:40 INFO - PROCESS | 6059 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52803/tests/kraken/driver.html?testName=audio-oscillator) 01:33:41 INFO - PROCESS | 6059 | RSS: Main: 194281472 01:33:41 INFO - PROCESS | 6059 | 01:33:43 INFO - PROCESS | 6059 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52803/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:33:44 INFO - PROCESS | 6059 | RSS: Main: 194191360 01:33:44 INFO - PROCESS | 6059 | 01:33:47 INFO - PROCESS | 6059 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52803/tests/kraken/driver.html?testName=imaging-darkroom) 01:33:47 INFO - PROCESS | 6059 | RSS: Main: 200146944 01:33:47 INFO - PROCESS | 6059 | 01:33:51 INFO - PROCESS | 6059 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52803/tests/kraken/driver.html?testName=imaging-desaturate) 01:33:51 INFO - PROCESS | 6059 | RSS: Main: 196300800 01:33:51 INFO - PROCESS | 6059 | 01:33:54 INFO - PROCESS | 6059 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52803/tests/kraken/driver.html?testName=json-parse-financial) 01:33:55 INFO - PROCESS | 6059 | RSS: Main: 196997120 01:33:55 INFO - PROCESS | 6059 | 01:33:56 INFO - PROCESS | 6059 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52803/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:33:57 INFO - PROCESS | 6059 | RSS: Main: 197615616 01:33:57 INFO - PROCESS | 6059 | 01:33:59 INFO - PROCESS | 6059 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:34:00 INFO - PROCESS | 6059 | RSS: Main: 197447680 01:34:00 INFO - PROCESS | 6059 | 01:34:02 INFO - PROCESS | 6059 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:34:02 INFO - PROCESS | 6059 | RSS: Main: 197615616 01:34:02 INFO - PROCESS | 6059 | 01:34:05 INFO - PROCESS | 6059 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:34:06 INFO - PROCESS | 6059 | RSS: Main: 197570560 01:34:06 INFO - PROCESS | 6059 | 01:34:09 INFO - PROCESS | 6059 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:34:09 INFO - PROCESS | 6059 | RSS: Main: 197836800 01:34:09 INFO - PROCESS | 6059 | 01:34:11 INFO - PROCESS | 6059 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52803/tests/kraken/driver.html?testName=ai-astar) 01:34:11 INFO - PROCESS | 6059 | RSS: Main: 199192576 01:34:11 INFO - PROCESS | 6059 | 01:34:11 INFO - PROCESS | 6059 | __start_tp_report 01:34:11 INFO - PROCESS | 6059 | _x_x_mozilla_page_load 01:34:11 INFO - PROCESS | 6059 | _x_x_mozilla_page_load_details 01:34:11 INFO - PROCESS | 6059 | |i|pagename|runs| 01:34:11 INFO - PROCESS | 6059 | |0;ai-astar;106;114;111;113;112;113;111;110;110;111 01:34:11 INFO - PROCESS | 6059 | |1;audio-beat-detection;151;124;123;168;125;126;127;127;142;123 01:34:11 INFO - PROCESS | 6059 | |2;audio-dft;164;165;165;166;166;164;163;162;169;163 01:34:11 INFO - PROCESS | 6059 | |3;audio-fft;77;76;76;106;77;77;77;75;105;75 01:34:11 INFO - PROCESS | 6059 | |4;audio-oscillator;83;82;106;83;83;83;102;82;81;97 01:34:11 INFO - PROCESS | 6059 | |5;imaging-gaussian-blur;117;117;117;117;118;118;117;118;117;117 01:34:11 INFO - PROCESS | 6059 | |6;imaging-darkroom;147;147;148;146;147;148;148;148;146;148 01:34:11 INFO - PROCESS | 6059 | |7;imaging-desaturate;97;96;97;95;96;96;97;96;97;97 01:34:11 INFO - PROCESS | 6059 | |8;json-parse-financial;55;54;54;54;57;55;55;55;54;60 01:34:11 INFO - PROCESS | 6059 | |9;json-stringify-tinderbox;63;62;63;63;64;63;62;61;63;64 01:34:11 INFO - PROCESS | 6059 | |10;stanford-crypto-aes;82;82;85;82;82;82;84;82;85;81 01:34:11 INFO - PROCESS | 6059 | |11;stanford-crypto-ccm;134;141;134;134;163;137;144;139;178;145 01:34:11 INFO - PROCESS | 6059 | |12;stanford-crypto-pbkdf2;167;171;167;167;171;175;172;167;170;171 01:34:11 INFO - PROCESS | 6059 | |13;stanford-crypto-sha256-iterative;71;67;68;67;67;66;67;68;69;68 01:34:11 INFO - PROCESS | 6059 | __end_tp_report 01:34:11 INFO - PROCESS | 6059 | __start_cc_report 01:34:11 INFO - PROCESS | 6059 | _x_x_mozilla_cycle_collect,832 01:34:11 INFO - PROCESS | 6059 | __end_cc_report 01:34:11 INFO - PROCESS | 6059 | __startTimestamp1480152851793__endTimestamp 01:34:11 INFO - PROCESS | 6059 | 01:34:11 INFO - PROCESS | 6059 | ------- Summary: start ------- 01:34:11 INFO - PROCESS | 6059 | Number of tests: 14 01:34:11 INFO - PROCESS | 6059 | 01:34:11 INFO - PROCESS | 6059 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.50 stddev:2.23 (2.0%) stddev-sans-first:1.41 01:34:11 INFO - PROCESS | 6059 | Values: 106.0 114.0 111.0 113.0 112.0 113.0 111.0 110.0 110.0 111.0 01:34:11 INFO - PROCESS | 6059 | 01:34:11 INFO - PROCESS | 6059 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:127.00 stddev:15.25 (12.0%) stddev-sans-first:14.82 01:34:11 INFO - PROCESS | 6059 | Values: 151.0 124.0 123.0 168.0 125.0 126.0 127.0 127.0 142.0 123.0 01:34:11 INFO - PROCESS | 6059 | 01:34:11 INFO - PROCESS | 6059 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.00 stddev:2.00 (1.2%) stddev-sans-first:2.11 01:34:11 INFO - PROCESS | 6059 | Values: 164.0 165.0 165.0 166.0 166.0 164.0 163.0 162.0 169.0 163.0 01:34:11 INFO - PROCESS | 6059 | 01:34:11 INFO - PROCESS | 6059 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.50 stddev:12.36 (16.2%) stddev-sans-first:12.97 01:34:11 INFO - PROCESS | 6059 | Values: 77.0 76.0 76.0 106.0 77.0 77.0 77.0 75.0 105.0 75.0 01:34:11 INFO - PROCESS | 6059 | 01:34:11 INFO - PROCESS | 6059 | [#4] audio-oscillator Cycles:10 Average:88.20 Median:83.00 stddev:9.55 (11.5%) stddev-sans-first:9.95 01:34:11 INFO - PROCESS | 6059 | Values: 83.0 82.0 106.0 83.0 83.0 83.0 102.0 82.0 81.0 97.0 01:34:11 INFO - PROCESS | 6059 | 01:34:11 INFO - PROCESS | 6059 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 01:34:11 INFO - PROCESS | 6059 | Values: 117.0 117.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 117.0 01:34:11 INFO - PROCESS | 6059 | 01:34:11 INFO - PROCESS | 6059 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 01:34:11 INFO - PROCESS | 6059 | Values: 147.0 147.0 148.0 146.0 147.0 148.0 148.0 148.0 146.0 148.0 01:34:11 INFO - PROCESS | 6059 | 01:34:11 INFO - PROCESS | 6059 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 01:34:11 INFO - PROCESS | 6059 | Values: 97.0 96.0 97.0 95.0 96.0 96.0 97.0 96.0 97.0 97.0 01:34:11 INFO - PROCESS | 6059 | 01:34:11 INFO - PROCESS | 6059 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:1.89 (3.4%) stddev-sans-first:2.00 01:34:11 INFO - PROCESS | 6059 | Values: 55.0 54.0 54.0 54.0 57.0 55.0 55.0 55.0 54.0 60.0 01:34:11 INFO - PROCESS | 6059 | 01:34:11 INFO - PROCESS | 6059 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 01:34:11 INFO - PROCESS | 6059 | Values: 63.0 62.0 63.0 63.0 64.0 63.0 62.0 61.0 63.0 64.0 01:34:11 INFO - PROCESS | 6059 | 01:34:11 INFO - PROCESS | 6059 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.00 stddev:1.42 (1.7%) stddev-sans-first:1.48 01:34:11 INFO - PROCESS | 6059 | Values: 82.0 82.0 85.0 82.0 82.0 82.0 84.0 82.0 85.0 81.0 01:34:11 INFO - PROCESS | 6059 | 01:34:11 INFO - PROCESS | 6059 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:142.50 stddev:14.50 (10.2%) stddev-sans-first:14.84 01:34:11 INFO - PROCESS | 6059 | Values: 134.0 141.0 134.0 134.0 163.0 137.0 144.0 139.0 178.0 145.0 01:34:11 INFO - PROCESS | 6059 | 01:34:11 INFO - PROCESS | 6059 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:171.00 stddev:2.74 (1.6%) stddev-sans-first:2.71 01:34:11 INFO - PROCESS | 6059 | Values: 167.0 171.0 167.0 167.0 171.0 175.0 172.0 167.0 170.0 171.0 01:34:11 INFO - PROCESS | 6059 | 01:34:11 INFO - PROCESS | 6059 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.40 (2.1%) stddev-sans-first:0.88 01:34:11 INFO - PROCESS | 6059 | Values: 71.0 67.0 68.0 67.0 67.0 66.0 67.0 68.0 69.0 68.0 01:34:11 INFO - PROCESS | 6059 | -------- Summary: end -------- 01:34:11 INFO - PROCESS | 6059 | 01:34:12 INFO - TEST-INFO | 6059: exit 0 01:34:13 INFO - TEST-OK | kraken | took 62853ms 01:34:13 INFO - SUITE-END | took 1179s 01:34:13 INFO - Completed test suite (00:19:39) 01:34:13 INFO - javascript benchmark 01:34:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7165.971064807464, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3205.615326160861, 3211.7270032047277, 3221.4845624700038, 3256.4789633658606, 3262.6411094779555, 5374.811881584145, 5622.746976386063, 5633.746481408336, 5633.8309850704445, 5691.402402747714, 5387.622866399353, 5538.806141785039, 5606.579506537016, 5637.689927054011, 5682.6306290091115, 4973.4280557735965, 4998.075356059141, 5020.774065167058, 5110.667806592578, 5115.641905066647, 4616.584507394334, 4907.730074845882, 5074.949250507503, 5168.689878607295, 5171.767270472819, 4858.684185527929, 5127.051495473349, 5164.173732202848, 5183.844484665466, 5199.818006369778, 4895.853124406273, 4929.852104436873, 4938.283948827436, 4995.925061124086, 5036.269740887551, 4965.205567109281, 5015.6238282128625, 5070.569001634865, 5076.720780357079, 5095.082885080684, 5511.0, 5521.834344969617, 5606.719664016783, 5610.915836262459, 5660.377358490563, 5757.68332741699, 5849.064149736065, 6008.429199226067, 6035.486983606354, 6043.335233124353, 5964.433378829004, 5973.342932277489, 5976.9402305977255, 5979.133025711291, 5980.491658209014, 5511.889762204773, 5536.058869992111, 5548.6948217848, 5560.610757246954, 5580.63725857822, 6133.417325354084, 6133.4264757247465, 6186.566940314135, 6199.039148931923, 6207.34822843604, 5970.77599092185, 5971.104334349882, 5974.372690867396, 5978.55160862937, 6010.939890601126, 5745.511631511368, 5804.506616937608, 6047.78832740852, 6060.0, 6061.8484537886025, 5767.625104368202, 5858.443447872445, 5937.762489500372, 5947.851303717442, 6057.757689692363, 5950.8809823803285, 6010.429009244115, 6013.368596297413, 6019.548533859978, 6029.728662210211, 4555.407796986437, 4573.108243892476, 4582.358469814229, 4589.10512450069, 4627.699199552018, 3927.6072392761066, 3961.2869683457257, 3971.801409929492, 3975.4036894465485, 3980.9203815924097, 5659.0, 5670.376258611549, 5670.688112153871, 5677.687727174963, 5711.885762284731, 5982.670953097621, 5986.940130598726, 5988.700564971734, 6001.12983617373, 6025.0661147522205, 5445.50990410865, 5453.400125986138, 5457.481539253765, 5539.335279766454, 5672.744726487318, 4934.802607895644, 4944.060628480577, 4948.4309304429735, 4962.15643340633, 4966.627502937295, 6097.373446762125, 6101.206843110367, 6116.396640261158, 6147.262328520606, 6167.814965551041, 5978.581499295007, 5981.162637230878, 5990.2212712348855, 6004.489618382312, 6031.969840150771, 5832.3292821326095, 5909.349971503218, 6043.123747056564, 6129.877402451837, 6162.352952939877, 5697.401772813795, 5700.059490184073, 5702.258706368311, 5712.571557133148, 5713.342965559014, 5793.478586927196, 5949.91075133882, 5974.551908606785, 5996.220491336098, 6046.637201767908, 5823.82528524145, 5850.297964244318, 5861.736221869941, 5863.120531920075, 5883.676397798162, 5847.064469685, 5853.268341457318, 5862.062070068769, 5875.970620146872, 5891.23413956183, 5580.330360356621, 5612.130119831432, 5624.268845050117, 5632.633878797865, 5710.172025056427, 5836.649801011953, 5911.55663325261, 5933.1396947443245, 5946.13781001761, 5947.821565353046, 5727.398623144676, 5762.510186634183, 5775.047117225611, 5780.393058728773, 5806.622569532967], "value": 5474.501596447023, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.6988426249825, 604.2959951656319, 608.7352001879183, 616.3620652624535, 653.0563335979506, 37545.249095018116, 40729.0, 41210.38184427232, 41237.0, 41363.58636413635, 41252.79373603135, 41982.0, 42089.78955105228, 42098.36852447216, 42208.15583688324, 8316.792080197998, 8559.22966932976, 8560.272376847975, 8575.485470871736, 10121.291509594332, 9997.900230974587, 10329.63846265381, 10329.741756456073, 10333.741656458611, 10338.379697218192, 10315.845262321034, 10325.483725813718, 10339.896601034006, 10362.067413932744, 10415.791684166312, 10279.897201028043, 10333.225008124384, 10367.688969330931, 10377.533011014522, 10384.221183411275, 10209.795804083951, 10306.536205870754, 10332.94833525835, 10333.328333658288, 10340.896591034068, 41169.382459263135, 41558.584414155775, 41559.0, 41564.376534352006, 41567.792161039004, 3564.4475106358555, 3645.5078564393734, 3741.0834345585235, 3823.4264860270905, 3979.602039796026, 30267.69732302693, 30912.0, 30919.381612367626, 31017.534736978963, 32014.679853201636, 4056.14820887611, 4178.749275043507, 4185.748855068706, 4313.698041137121, 4346.15250026245, 342998.0, 343142.0, 343626.0, 344100.0, 344625.27687361656, 59794.40205597975, 59821.40178598245, 60007.0, 60228.39771602316, 60281.0, 61660.0, 62125.37874621286, 62340.0, 62528.374716252256, 62616.37383626196, 16289.429869954494, 16477.0, 16599.0, 16618.169091545373, 16677.166141692865, 11888.405579720978, 12172.878271217174, 13137.540186093442, 13216.537421190404, 13370.197788132744, 18486.042233242617, 19179.80820191808, 19357.83442007486, 19425.212083643837, 19443.8055619442, 6894.931050689529, 7042.718291268292, 7284.490085694057, 7334.816629584197, 7494.70021199146, 948.691675205561, 1008.7679833638305, 1015.8064274477607, 1080.8000519903685, 1103.586155191787, 31881.0, 32396.190095247806, 32429.0, 32453.0, 32909.83545082307, 1051.1695760349392, 1108.257467496763, 1110.4225802582612, 1119.4738472917716, 1123.3709122891207, 15508.5347439577, 16934.40729574459, 16992.660146796996, 17078.316867325168, 17108.0, 486923.0, 491205.0, 491705.0, 492922.0, 493260.0, 57002.714986424806, 57274.42725572774, 57572.71213643905, 57612.0, 57739.422605773405, 1302.0820321673198, 1326.8142460055599, 1328.8206092177431, 1342.8992825538123, 1358.0629365737807, 30433.0, 31316.782839681095, 31778.205544861565, 31867.36265274728, 32505.0, 51468.74265628648, 51522.74238628783, 51686.0, 51776.0, 51780.741096294274, 434846.0, 436574.0, 441713.0, 442287.0, 442628.0, 35793.284134316644, 41443.1711365777, 41757.0, 42469.787651061546, 42779.786101069294, 44495.777521112184, 46079.76960115178, 46564.53435465602, 46869.2969605463, 47760.0, 38908.0, 40251.59748402596, 40744.18511629692, 41329.793351033055, 42234.36648450214, 39801.60198397979, 40046.0, 40876.59123408728, 41099.0, 41492.170156597305, 40096.59903400928, 40210.19579608333, 40350.0, 40423.79788101158, 40484.79757601193, 33508.0, 35254.53554699026, 36090.27819443649, 36222.275554489286, 36691.81654091713, 27525.17424477269, 27621.585676215276, 27780.44439111166, 27943.301417463914, 27984.362032935587], "value": 20487.293774569058, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.55241367599905, 388.9824957876895, 394.6448196623039, 398.4004073868827, 426.5478592691747, 17489.300427982882, 18856.34002809902, 18865.0, 19011.904940475313, 19591.90204048978, 18495.537611559717, 18643.29672197534, 19220.903895480504, 19299.13153908074, 19308.455323574115, 5570.972145139279, 5587.720613969305, 5729.1119876419225, 5767.192593036978, 5829.708514574254, 5633.436656334375, 5752.395998420168, 5753.194552762617, 5753.827385178452, 5754.568407369443, 5505.284313039299, 5630.183623374608, 5650.943490565083, 5691.857703557403, 5701.77192912283, 5665.23519324892, 5666.575006874501, 5671.574631902624, 5717.914231286534, 5729.0, 4924.6060315175055, 5063.924041139386, 5079.3650793650795, 5097.133487307166, 5110.10573149701, 21979.23072692464, 22079.889600552055, 22122.0, 22272.329575281758, 22758.772412275997, 2457.9877100614563, 2501.6247562865533, 2643.0842607313157, 2743.43759529296, 2911.4132797625343, 10073.44596047217, 10393.272470927039, 10765.246432749711, 10897.128229741602, 14312.21282829444, 1890.1022014542982, 1922.5385907382267, 1951.6194342103295, 1955.501347156466, 1975.585127123306, 84036.99999999939, 84155.5792221041, 84610.0, 87301.56349218277, 88708.11291887063, 9409.247260219303, 9698.175655069257, 9920.0, 10061.79876402468, 10124.949375253223, 13423.865761342457, 13441.0, 13460.394282257126, 13466.124701894345, 13470.797938030937, 7174.461915356369, 7267.89098163528, 7565.243475652391, 7697.345725613385, 7761.379089672925, 7133.82165445868, 7223.8555228896175, 7407.148177959496, 7465.925340746631, 7497.66260518278, 4153.979230103891, 4181.351890456984, 4217.7891105444605, 4223.113146239324, 4292.935605965913, 1884.180381534037, 2021.7169596256535, 2048.9077991490417, 2081.427607407975, 2141.5716856628737, 856.3406177243488, 956.4070276428658, 967.2890425537224, 1016.2784423059562, 1052.7631282961427, 18730.0, 19518.5120371989, 19577.0, 19663.508412289808, 19761.40715778529, 991.8462638291077, 997.7705127820642, 1039.101177481473, 1065.3820783945293, 1076.7146706122883, 10211.336263142872, 10762.515686794113, 10838.837417438745, 10927.289726167774, 10950.671479855617, 447418.0, 467001.0, 468897.0, 474226.0, 475578.0, 61280.0, 90271.54864225637, 93043.0, 93188.53405732928, 94296.52851735834, 989.7723523589615, 1045.534737042009, 1073.983890241647, 1077.531273895842, 1079.0019232210332, 16631.251593678557, 16684.49946501607, 17006.659866802842, 17428.912855435643, 17514.299428023245, 41128.58871411248, 41238.0, 41666.37500437435, 42140.0, 42858.35712464378, 55032.44967550434, 56368.43631563632, 56471.0, 57104.42895570991, 57220.71389643025, 8081.232282933112, 8290.544020078712, 8658.0, 8715.782105447415, 8873.467591944504, 9495.477748723886, 12200.145989780985, 12587.307698076695, 12592.0, 12963.0, 10967.890321096687, 11186.32882027081, 11235.66293011211, 11501.597444089417, 11683.649490515298, 10555.208359372924, 10645.520951557353, 11048.337099774039, 11304.152188586053, 11371.090312774793, 10802.837957430802, 11346.602868899548, 11429.942850285695, 11461.369624670722, 11522.251053681484, 8151.184881511801, 8424.915750842658, 8640.654373824977, 8705.173008564176, 8825.735227943173, 11287.661370158909, 11296.0, 11448.885511145116, 11499.022583080532, 11597.18819682614], "value": 9037.949024774236, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.8334991475976, 1451.1873350923483, 1594.7607858821182, 1730.9740353894701, 1733.4799560131964, 8078.868958345829, 8395.202455766708, 8684.47893126412, 8707.608157632905, 8707.869381959275, 8630.741077767678, 8760.912390876088, 8777.561121943909, 8793.736187914374, 8848.51333176675, 2291.0377641390614, 2321.7446080931086, 2326.4532834783813, 2326.7440581536016, 2332.6384410416413, 2333.230034088747, 2364.326167042393, 2384.9642255366184, 2387.3673476528734, 2387.689600351952, 2282.9771702283015, 2290.7251129864358, 2294.5640328337645, 2308.249818808894, 2308.6421604651223, 2222.29997550771, 2241.3500084975417, 2270.0919632147275, 2273.545290941818, 2275.0444813178424, 2293.5068960173644, 2301.1255722825385, 2312.5374925014894, 2313.4794671198847, 2313.652952057188, 8221.342292616577, 8361.0, 8412.663493460253, 8415.621297041587, 8475.703350382768, 5188.948110518922, 5225.895482090337, 5323.760430780624, 5337.70642614656, 5346.117890548055, 3064.5096784514594, 3119.2825650100376, 3372.9494057589154, 3377.392069427502, 3397.69420752131, 1195.3365881935522, 1195.545692636801, 2011.185469884699, 2014.7280117184287, 2050.846186536001, 11714.355710435922, 11749.4712737927, 11800.881991180064, 11874.16880818343, 11879.703007424798, 4299.527052024275, 4445.688801783844, 4562.5665561771575, 4634.235351167087, 4652.813887444532, 9079.773005674911, 9113.908860911439, 9116.817663646823, 9124.498152601538, 9141.31440141992, 5075.5178258065425, 5083.186690129562, 5084.13569693153, 5087.186050232019, 5093.439721630618, 4733.810647574059, 4752.1921273383605, 4895.265710143507, 4947.727874966839, 5017.347744793226, 3798.4302354647025, 3803.4484999675446, 3846.211526637033, 3870.148567315186, 3981.1241526864624, 1209.1777591238042, 1216.7019080325376, 1229.8093795461539, 1231.6982339326921, 1233.112159245342, 803.3292201012221, 949.0793929887998, 957.2724729205854, 966.0580933589835, 969.680005598151, 5512.751926163332, 5705.828825135252, 5863.179154918314, 5906.877693238271, 5982.192404025401, 448.91695036418366, 455.8176729308237, 455.9977200113978, 459.0612198054919, 465.7834107140196, 3730.925381492355, 3863.517060367454, 3925.9018524537114, 3927.7446965947124, 4065.1869626074904, 10096.848547271797, 10400.890535069919, 10481.213908956859, 10560.049595536439, 10589.205809564313, 10417.42704151279, 10483.423411712429, 10517.580126682953, 10532.842007369742, 10679.83980240297, 7790.065192176975, 7856.450048496665, 7884.172161922916, 7917.0895347034675, 7980.526036928571, 5547.389787123332, 5577.776888924398, 5641.774329026793, 5664.830055098354, 5872.148538461814, 9517.619295228391, 9585.808283834145, 9635.084666956627, 9662.3236373456, 9746.366486178376, 9615.951920240354, 9651.324407291422, 9656.420614763138, 9744.75638109053, 9756.951215243878, 6340.71466784005, 6542.509311801538, 6842.0, 7034.788956331318, 7103.644817759195, 8063.677452902053, 8382.580870956306, 8385.32917366597, 8389.538575378412, 8398.076211616595, 7053.4004609608755, 7127.2516385778745, 7201.783946481614, 7245.927540724525, 7441.516301440389, 7158.4273258140265, 7254.129504459499, 7420.6289685516585, 7476.850462990601, 7549.50928189666, 6597.888675623946, 6746.257911629618, 6761.019652150509, 6767.93232067673, 6775.796726098225, 4906.607471402208, 4998.925016124688, 5055.292259083658, 5060.671056381323, 5120.667156634807, 5046.066477701637, 5054.747262636927, 5067.695938243717, 5162.741862906914, 5173.22401639757], "value": 4465.210840853591, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.2920221523724, 342.1736506337196, 351.74147001953577, 353.1453881606512, 356.6647351489601, 5360.437154098812, 5452.418798548416, 5515.31782806244, 5553.916691249629, 5587.8603034924145, 5324.92012619811, 5458.372287186965, 5478.835634930959, 5485.61600687952, 5502.174673798932, 4330.917270682329, 4369.759663218521, 4370.562943705636, 4375.4311939447825, 4388.2978723404185, 4266.445362102922, 4303.784810759449, 4304.870853874389, 4360.171567402199, 4413.88965275869, 4263.0, 4274.8244232835905, 4288.506821715511, 4292.720973136752, 4297.39836422901, 4271.487421509408, 4295.183915056129, 4297.8495752648505, 4302.548232435596, 4314.158739045887, 3851.094992676719, 3859.8649047283493, 3862.613738626115, 3879.9612003879884, 3882.223555288925, 5124.666896651705, 5283.471652834724, 5347.812826551091, 5382.865428364283, 5390.789776191782, 4977.701337919736, 4980.427250866161, 4993.575546078588, 5033.874153146164, 5041.924371134399, 5603.859903502404, 5705.286839145107, 5729.398413166599, 5750.683712395817, 5767.221425107598, 4220.261454245495, 4221.894452638678, 4225.415469199051, 4235.53409124996, 4261.126469073833, 5962.522998160137, 5977.282726072855, 5996.550258730569, 5999.310079340845, 6027.246594175772, 4288.807003684841, 4328.718633288826, 4383.627391671744, 4395.780210989502, 4402.977985110054, 4363.759993200341, 4404.3263559847055, 4419.64642828573, 4424.0, 4425.601695847389, 4970.0, 4971.980743947482, 4995.575376093, 4997.90004199914, 5005.274235235943, 5694.259746232963, 5771.192033115367, 5781.0, 5798.911767204111, 5801.593888427769, 1465.5198249767598, 1476.497990683173, 1479.844616315293, 1489.6722721001363, 1493.7087267982856, 1016.5462294788407, 1033.9741506462399, 1043.0977204717865, 1043.598214687351, 1055.2033214922685, 5332.253484512172, 5365.839024829262, 5374.865628359323, 5398.4871437213405, 5404.648697834707, 5718.51392631631, 5770.480656740913, 5778.3531693468, 5783.248177736868, 5819.0689489681445, 5254.264402983586, 5471.671699698031, 5475.6181061238485, 5657.57568182388, 5658.91511627326, 3047.238190452387, 3058.98470507646, 3066.7546596272246, 3069.6210436911574, 3107.9533806992913, 5706.771729130788, 5942.0, 5958.910616340759, 5974.2233509643465, 5986.431289027535, 5792.395045938405, 5807.332156801937, 5833.533317334603, 5846.473817356458, 5862.8534286642325, 5926.525877929756, 5959.791407300723, 5974.924513587509, 5983.311919129356, 5984.611000285055, 5556.499915007668, 5601.831945041656, 5700.629459085146, 5713.914421236136, 5732.671832766235, 5638.23883775685, 5699.230603868425, 5708.343540492897, 5721.685307308138, 5747.942520574908, 5617.185508101221, 5886.381929897299, 5921.14143449206, 5932.288125424977, 5947.851303717442, 4024.2756303865585, 4034.7377420467574, 4145.647619952338, 4159.1681663668, 4177.937330940099, 5875.764969401347, 5895.0, 5957.106434034929, 5972.970135149297, 5979.342272350125, 5587.776488940397, 5725.570582206435, 5733.971330143323, 5751.396103409082, 5796.739146738491, 5701.287339082614, 5736.99602569557, 5737.6557406554075, 5740.741666624928, 5741.655500669973, 5709.771609135754, 5714.657120572779, 5728.0, 5747.252857128547, 5798.884022319446, 5585.273914391103, 5735.311762588349, 5765.654060756368, 5770.249867517364, 5815.5929084963645, 5656.208130861601, 5656.43435656431, 5663.1788390682295, 5687.374388817309, 5689.715514224189], "value": 4394.484416202203, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.2288693880201, 730.4813582356527, 760.9657565409556, 774.4191856107917, 776.3168411797617, 14215.71568568628, 15186.088834669927, 15355.923220383882, 15371.231438428076, 15374.385024599003, 13683.589492315246, 13799.931000344985, 13801.447942082305, 13830.23933683647, 13849.0, 652.797632733854, 676.1649363036646, 752.1726101288566, 771.961401929904, 778.5834578500503, 776.4487214077983, 788.1330536409961, 788.5229436191108, 789.0767801672029, 790.0913948958686, 811.111832543367, 817.8609636361803, 819.72948926854, 820.6102101501799, 825.3727167352826, 813.6297984417076, 813.9308158806508, 814.5764202614607, 815.787895147263, 817.5217497763815, 605.0138274612398, 605.5186127028978, 605.8152263559613, 606.7087797857009, 606.7178761875749, 13802.0, 13962.790558141636, 13968.301584920713, 13970.231637259947, 14014.509492167725, 13114.0, 13596.38816253261, 13890.722185556333, 13968.231747253896, 14164.36260368286, 10761.569537218502, 11040.723981900437, 11076.944615276952, 11180.105591552656, 11263.718407039807, 3526.400511912981, 3538.5046093546925, 3603.8738644147593, 3672.0, 3710.7588006779474, 62290.0, 62600.0, 63323.0, 63620.68189659022, 64136.03795943064, 10509.632162874415, 10606.098481628993, 10637.521311540999, 10647.467626618638, 11049.668509944715, 17627.55931101733, 17678.911605442147, 17781.555461113574, 17784.0, 17794.199261033285, 7672.578008209602, 7706.0, 7778.961105194438, 7816.570088645065, 7855.960720196363, 4336.82652693895, 4464.330350447459, 4518.593326600556, 4519.932201016987, 4528.275475923902, 3523.9295214095573, 3574.8748793792092, 3576.9284614307567, 3606.1705807664384, 3626.6192049834917, 602.6384169498266, 616.8026231605843, 618.9071639254148, 621.3475850357107, 629.7166275176189, 697.7767114523303, 699.5173330402006, 713.846522997558, 715.2561336210387, 717.1322699533623, 9509.5720692569, 9622.566984485715, 9887.752806179904, 9999.400095984753, 10103.494825258707, 618.9288231853304, 648.7275344355382, 695.3672158335991, 697.7348607529107, 697.8150790040643, 4358.2240311344685, 4369.453818272716, 4602.6774135626065, 4776.331313616097, 4827.8551643450755, 49491.05089491022, 50625.24062139071, 74028.0, 77079.2292077072, 79562.60218698869, 45799.09358035772, 56625.43374566284, 58687.0, 73621.0, 74849.0, 62534.374656252854, 63508.3649163521, 64150.0, 65607.67196163989, 65862.0, 8402.579871006303, 8610.913890861011, 8702.347323950855, 8726.82546349082, 8878.200961913459, 42551.31935487156, 42832.357514636686, 43571.0, 44563.0, 44924.326135108655, 58582.0, 61870.38129618646, 62725.763595667806, 62996.0, 63717.681411592646, 11009.339439633648, 11053.557857685924, 11075.778484430428, 11261.436928153724, 11299.71750706206, 12355.876441235472, 12515.374231288217, 12559.87440125587, 12833.230006199658, 13228.338583071001, 11309.223103820603, 11645.301281923112, 11646.708832278922, 11750.23623464472, 12055.0, 11551.653450396501, 11626.709332266422, 11912.702182445508, 11936.820947685965, 11937.343446110548, 11240.0, 11360.204785664924, 11523.156463665235, 11897.940510297392, 12163.939180304042, 10649.680509584725, 10881.891181088404, 10955.890441095487, 11320.433978300887, 11599.072074233873, 11087.833682494931, 11145.442727863412, 11379.317240965569, 11473.737888832055, 11530.135239857213], "value": 6807.011814341406, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 111.0, 113.0, 112.0, 113.0, 111.0, 110.0, 110.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 123.0, 168.0, 125.0, 126.0, 127.0, 127.0, 142.0, 123.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 165.0, 166.0, 166.0, 164.0, 163.0, 162.0, 169.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 106.0, 77.0, 77.0, 77.0, 75.0, 105.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 106.0, 83.0, 83.0, 83.0, 102.0, 82.0, 81.0, 97.0], "value": 88.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 146.0, 147.0, 148.0, 148.0, 148.0, 146.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 97.0, 95.0, 96.0, 96.0, 97.0, 96.0, 97.0, 97.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 57.0, 55.0, 55.0, 55.0, 54.0, 60.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 63.0, 64.0, 63.0, 62.0, 61.0, 63.0, 64.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 85.0, 82.0, 82.0, 82.0, 84.0, 82.0, 85.0, 81.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 141.0, 134.0, 134.0, 163.0, 137.0, 144.0, 139.0, 178.0, 145.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 171.0, 167.0, 167.0, 171.0, 175.0, 172.0, 167.0, 170.0, 171.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 68.0, 67.0, 67.0, 66.0, 67.0, 68.0, 69.0, 68.0], "value": 67.8, "unit": "score"}]}]} 01:34:13 INFO - Return code: 0 01:34:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:34:13 ERROR - # TBPL SUCCESS # 01:34:13 INFO - Running post-action listener: _resource_record_post_action 01:34:13 INFO - [mozharness: 2016-11-26 09:34:13.608895Z] Finished run-tests step (success) 01:34:13 INFO - Running post-run listener: _resource_record_post_run 01:34:13 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 410075136; Read time: 28; Write time: 252280 01:34:13 INFO - TinderboxPrint: CPU usage
13.4% 01:34:13 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 01:34:13 INFO - TinderboxPrint: I/O write bytes / time
410,075,136 / 252,280 01:34:13 INFO - TinderboxPrint: CPU idle
8,260.8 (86.5%) 01:34:13 INFO - TinderboxPrint: CPU user
1,223.9 (12.8%) 01:34:13 INFO - TinderboxPrint: Swap in / out
0 / 0 01:34:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120819712; Read time: 0; Write time: 74176 01:34:13 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289255424; Read time: 12; Write time: 178104 01:34:14 INFO - Running post-run listener: _upload_blobber_files 01:34:14 INFO - Blob upload gear active. 01:34:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:34:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:34:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:34:14 INFO - (blobuploader) - INFO - Open directory for files ... 01:34:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:34:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:34:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:34:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:34:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:34:15 INFO - (blobuploader) - INFO - Done attempting. 01:34:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:34:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:34:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:34:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:34:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:34:16 INFO - (blobuploader) - INFO - Done attempting. 01:34:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:34:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:34:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:34:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:34:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:34:19 INFO - (blobuploader) - INFO - Done attempting. 01:34:19 INFO - (blobuploader) - INFO - Iteration through files over. 01:34:19 INFO - Return code: 0 01:34:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:34:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:34:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/179944192bddafdc1c922a7cafd840dcacbdc055539c02027b7ca118d4c3ed5925f0c8d274d961d2a0d6aff2ee58be2596e77d04b9cef7f7a5d39ce63db675e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/502752c64e6871e040d6510abb17b56616903c083ca1b50094438837d090f00c3b36b376faa74ea1af2db485328d25aa48d37abac5bfee46a583c60c061caa7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/056b8cb0db3504851a5c176bcb0ce9a6447b5429f69e70e4804c46a54fb3acd3e2e73b54cf532d50f956c1a77ed19a10b5ecef8c2c12081592d7da7218e523f0"} 01:34:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:34:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:34:19 INFO - Contents: 01:34:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/179944192bddafdc1c922a7cafd840dcacbdc055539c02027b7ca118d4c3ed5925f0c8d274d961d2a0d6aff2ee58be2596e77d04b9cef7f7a5d39ce63db675e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/502752c64e6871e040d6510abb17b56616903c083ca1b50094438837d090f00c3b36b376faa74ea1af2db485328d25aa48d37abac5bfee46a583c60c061caa7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/056b8cb0db3504851a5c176bcb0ce9a6447b5429f69e70e4804c46a54fb3acd3e2e73b54cf532d50f956c1a77ed19a10b5ecef8c2c12081592d7da7218e523f0"} 01:34:19 INFO - Running post-run listener: copy_logs_to_upload_dir 01:34:19 INFO - Copying logs to upload dir... 01:34:19 INFO - mkdir: /builds/slave/test/build/upload/logs 01:34:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.766757 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-26 01:34:19.437032) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 01:34:19.444987) ========= 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=41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/179944192bddafdc1c922a7cafd840dcacbdc055539c02027b7ca118d4c3ed5925f0c8d274d961d2a0d6aff2ee58be2596e77d04b9cef7f7a5d39ce63db675e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/502752c64e6871e040d6510abb17b56616903c083ca1b50094438837d090f00c3b36b376faa74ea1af2db485328d25aa48d37abac5bfee46a583c60c061caa7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/056b8cb0db3504851a5c176bcb0ce9a6447b5429f69e70e4804c46a54fb3acd3e2e73b54cf532d50f956c1a77ed19a10b5ecef8c2c12081592d7da7218e523f0"} build_url:https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011689 build_url: 'https://queue.taskcluster.net/v1/task/CXRld8dlR1mxTVUvDRLrdg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/179944192bddafdc1c922a7cafd840dcacbdc055539c02027b7ca118d4c3ed5925f0c8d274d961d2a0d6aff2ee58be2596e77d04b9cef7f7a5d39ce63db675e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/502752c64e6871e040d6510abb17b56616903c083ca1b50094438837d090f00c3b36b376faa74ea1af2db485328d25aa48d37abac5bfee46a583c60c061caa7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/056b8cb0db3504851a5c176bcb0ce9a6447b5429f69e70e4804c46a54fb3acd3e2e73b54cf532d50f956c1a77ed19a10b5ecef8c2c12081592d7da7218e523f0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 01:34:19.473647) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 01:34:19.473976) ========= 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=41bf3e9aed84707956354da8000001c5-1480151281.950894-637523709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 01:34:19.558386) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 01:34:19.561741) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 01:34:19.562030) ========= ========= Total master_lag: 0.19 =========