builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1478872331.07 results: success (0) buildid: 20161111030203 builduid: 877d3042e6be47fe855c1bdb51df7af8 revision: d38d06f85ef5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.065408) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.065847) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.066127) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.081591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.081996) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-11 05:52:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-11-11 05:52:12 (43.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098961 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.195006) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.195446) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013492 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.250248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.250604) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d38d06f85ef5 --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 d38d06f85ef5 --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=e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-11 05:52:12,565 Setting DEBUG logging. 2016-11-11 05:52:12,565 attempt 1/10 2016-11-11 05:52:12,565 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d38d06f85ef5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-11 05:52:12,861 unpacking tar archive at: mozilla-central-d38d06f85ef5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639775 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.904371) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.904686) ========= script_repo_revision: d38d06f85ef5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.905089) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.905377) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.914955) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-11 05:52:11.915245) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:52:13 INFO - MultiFileLogger online at 20161111 05:52:13 in /builds/slave/test 05:52:13 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 05:52:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:52:13 INFO - {'append_to_log': False, 05:52:13 INFO - 'base_work_dir': '/builds/slave/test', 05:52:13 INFO - 'blob_upload_branch': 'Firefox', 05:52:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:52:13 INFO - 'branch': 'Firefox', 05:52:13 INFO - 'buildbot_json_path': 'buildprops.json', 05:52:13 INFO - 'config_files': ('talos/linux_config.py',), 05:52:13 INFO - 'default_actions': ('clobber', 05:52:13 INFO - 'read-buildbot-config', 05:52:13 INFO - 'download-and-extract', 05:52:13 INFO - 'populate-webroot', 05:52:13 INFO - 'create-virtualenv', 05:52:13 INFO - 'install', 05:52:13 INFO - 'run-tests'), 05:52:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:52:13 INFO - 'download_minidump_stackwalk': True, 05:52:13 INFO - 'download_symbols': 'ondemand', 05:52:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:52:13 INFO - 'tooltool.py': '/tools/tooltool.py', 05:52:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:52:13 INFO - '/tools/misc-python/virtualenv.py')}, 05:52:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:52:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:52:13 INFO - 'installer_path': 'installer.exe', 05:52:13 INFO - 'log_level': 'info', 05:52:13 INFO - 'log_name': 'talos', 05:52:13 INFO - 'log_to_console': True, 05:52:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:52:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:52:13 INFO - 'opt_config_files': (), 05:52:13 INFO - 'pip_index': False, 05:52:13 INFO - 'sps_profile': False, 05:52:13 INFO - 'sps_profile_interval': 0, 05:52:13 INFO - 'suite': 'dromaeojs-e10s', 05:52:13 INFO - 'system_bits': '32', 05:52:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:52:13 INFO - 'title': 'talos-linux64-ix-067', 05:52:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:52:13 INFO - 'use_talos_json': True, 05:52:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:52:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:52:13 INFO - 'work_dir': 'build'} 05:52:13 INFO - [mozharness: 2016-11-11 13:52:13.328609Z] Running clobber step. 05:52:13 INFO - Running pre-action listener: _resource_record_pre_action 05:52:13 INFO - Running main action method: clobber 05:52:13 INFO - rmtree: /builds/slave/test/build 05:52:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:52:14 INFO - Running post-action listener: _resource_record_post_action 05:52:14 INFO - [mozharness: 2016-11-11 13:52:14.307422Z] Finished clobber step (success) 05:52:14 INFO - [mozharness: 2016-11-11 13:52:14.307520Z] Running read-buildbot-config step. 05:52:14 INFO - Running pre-action listener: _resource_record_pre_action 05:52:14 INFO - Running main action method: read_buildbot_config 05:52:14 INFO - Using buildbot properties: 05:52:14 INFO - { 05:52:14 INFO - "project": "", 05:52:14 INFO - "product": "firefox", 05:52:14 INFO - "script_repo_revision": "production", 05:52:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:52:14 INFO - "repository": "", 05:52:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:52:14 INFO - "buildid": "20161111030203", 05:52:14 INFO - "stage_platform": "linux64-pgo", 05:52:14 INFO - "basedir": "/builds/slave/test", 05:52:14 INFO - "nightly_build": "True", 05:52:14 INFO - "buildnumber": 181, 05:52:14 INFO - "slavename": "talos-linux64-ix-067", 05:52:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:52:14 INFO - "platform": "ubuntu64_hw", 05:52:14 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:52:14 INFO - "branch": "mozilla-central", 05:52:14 INFO - "repo_path": "mozilla-central", 05:52:14 INFO - "revision": "d38d06f85ef5", 05:52:14 INFO - "pgo_build": "True", 05:52:14 INFO - "builduid": "877d3042e6be47fe855c1bdb51df7af8", 05:52:14 INFO - "slavebuilddir": "test" 05:52:14 INFO - } 05:52:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:52:14 INFO - Running post-action listener: _resource_record_post_action 05:52:14 INFO - [mozharness: 2016-11-11 13:52:14.310205Z] Finished read-buildbot-config step (success) 05:52:14 INFO - [mozharness: 2016-11-11 13:52:14.310294Z] Running download-and-extract step. 05:52:14 INFO - Running pre-action listener: _resource_record_pre_action 05:52:14 INFO - Running main action method: download_and_extract 05:52:14 INFO - mkdir: /builds/slave/test/build/tests 05:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:14 INFO - trying https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:52:14 INFO - Downloading https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:52:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:52:14 INFO - Downloaded 1361 bytes. 05:52:14 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:52:14 INFO - Using the following test package requirements: 05:52:14 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:14 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:52:14 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:52:14 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:14 INFO - u'jsshell-linux-x86_64.zip'], 05:52:14 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:52:14 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:14 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:52:14 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:52:14 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:52:14 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:52:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:52:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:52:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:52:14 INFO - Fetch https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:52:15 INFO - Http code: 200 05:52:15 INFO - via: 1.1 373880a309382d9266a9313233b86d25.cloudfront.net (CloudFront) 05:52:15 INFO - x-amz-cf-id: Y8bfmNdzFfYHWTKDyuDRSwygHwv-I6EBfEkfWlRSiPkiKypx2em5Fg== 05:52:15 INFO - x-amz-version-id: FLAc._B8ezsvlykDYDowJ2Sg2VxSJNBK 05:52:15 INFO - Expected file size: 21969016 05:52:15 INFO - Obtained file size: 21969016 05:52:19 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:52:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:52:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:52:19 INFO - Fetch https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:52:20 INFO - Http code: 200 05:52:20 INFO - via: 1.1 d01884a3320364227d925bce1a38f0ad.cloudfront.net (CloudFront) 05:52:20 INFO - x-amz-cf-id: -Qt5iXLZf1KiSMF2UhD-Mr0xQPL3XXcMT4qkHeEX8IAr_-npW5YNHA== 05:52:20 INFO - x-amz-version-id: FLAc._B8ezsvlykDYDowJ2Sg2VxSJNBK 05:52:20 INFO - Expected file size: 21969016 05:52:20 INFO - Obtained file size: 21969016 05:52:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:52:25 INFO - Fetch https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:52:25 INFO - Http code: 200 05:52:25 INFO - via: 1.1 68e4011ca1c00bec92bb202e1ddce131.cloudfront.net (CloudFront) 05:52:25 INFO - x-amz-cf-id: r4qo0dcGzECyOGtCqAwPbleerFlOh4t13Roq_ezbLJrU9j9PsL-rKw== 05:52:25 INFO - x-amz-version-id: MT_MirC2LfTcKKWsKOhuHCM6C4djdXIm 05:52:25 INFO - Expected file size: 14409038 05:52:25 INFO - Obtained file size: 14409038 05:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:26 INFO - trying https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:52:26 INFO - Downloading https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:52:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:52:28 INFO - Downloaded 59304708 bytes. 05:52:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:52:28 INFO - mkdir: /builds/slave/test/properties 05:52:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:52:28 INFO - Writing to file /builds/slave/test/properties/build_url 05:52:28 INFO - Contents: 05:52:28 INFO - build_url:https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:52:28 INFO - Running post-action listener: _resource_record_post_action 05:52:28 INFO - Running post-action listener: set_extra_try_arguments 05:52:28 INFO - [mozharness: 2016-11-11 13:52:28.744931Z] Finished download-and-extract step (success) 05:52:28 INFO - [mozharness: 2016-11-11 13:52:28.745197Z] Running populate-webroot step. 05:52:28 INFO - Running pre-action listener: _resource_record_pre_action 05:52:28 INFO - Running main action method: populate_webroot 05:52:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:52:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:52:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:52:28 INFO - '--tppagecycles', 05:52:28 INFO - '7'], 05:52:28 INFO - 'tests': ['tsvgm']}}, 05:52:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:52:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:52:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:52:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:52:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:28 INFO - 'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:28 INFO - 'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['damp', 'tps']}, 05:52:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:28 INFO - 'tests': ['damp', 'tps']}, 05:52:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['dromaeo_dom']}, 05:52:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:52:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['basic_compositor_video']}, 05:52:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:52:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['a11yr', 05:52:28 INFO - 'ts_paint', 05:52:28 INFO - 'tpaint', 05:52:28 INFO - 'sessionrestore', 05:52:28 INFO - 'sessionrestore_no_auto_restore', 05:52:28 INFO - 'tabpaint']}, 05:52:28 INFO - 'other-e10s': {'tests': ['a11yr', 05:52:28 INFO - 'ts_paint', 05:52:28 INFO - 'tpaint', 05:52:28 INFO - 'sessionrestore', 05:52:28 INFO - 'sessionrestore_no_auto_restore', 05:52:28 INFO - 'tabpaint']}, 05:52:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:52:28 INFO - 'ts_paint', 05:52:28 INFO - 'tpaint', 05:52:28 INFO - 'sessionrestore', 05:52:28 INFO - 'sessionrestore_no_auto_restore', 05:52:28 INFO - 'tabpaint']}, 05:52:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:52:28 INFO - 'ts_paint', 05:52:28 INFO - 'tpaint', 05:52:28 INFO - 'sessionrestore', 05:52:28 INFO - 'sessionrestore_no_auto_restore', 05:52:28 INFO - 'tabpaint']}, 05:52:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['a11yr', 05:52:28 INFO - 'ts_paint', 05:52:28 INFO - 'tpaint', 05:52:28 INFO - 'sessionrestore', 05:52:28 INFO - 'sessionrestore_no_auto_restore', 05:52:28 INFO - 'tabpaint']}, 05:52:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['a11yr', 05:52:28 INFO - 'ts_paint', 05:52:28 INFO - 'tpaint', 05:52:28 INFO - 'sessionrestore', 05:52:28 INFO - 'sessionrestore_no_auto_restore', 05:52:28 INFO - 'tabpaint']}, 05:52:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['tsvgx', 05:52:28 INFO - 'tsvgr_opacity', 05:52:28 INFO - 'tart', 05:52:28 INFO - 'tscrollx', 05:52:28 INFO - 'cart']}, 05:52:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:52:28 INFO - 'tsvgr_opacity', 05:52:28 INFO - 'tart', 05:52:28 INFO - 'tscrollx', 05:52:28 INFO - 'cart']}, 05:52:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:28 INFO - 'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['tp5o']}, 05:52:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:28 INFO - 'tests': ['tp5o']}, 05:52:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:28 INFO - 'talos_options': ['--disable-e10s', 05:52:28 INFO - '--xperf_path', 05:52:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:28 INFO - 'tests': ['tp5n']}, 05:52:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:28 INFO - 'talos_options': ['--xperf_path', 05:52:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:28 INFO - 'tests': ['tp5n']}}, 05:52:28 INFO - 'talos.zip': {'path': '', 05:52:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:52:28 INFO - Running post-action listener: _resource_record_post_action 05:52:28 INFO - [mozharness: 2016-11-11 13:52:28.766035Z] Finished populate-webroot step (success) 05:52:28 INFO - [mozharness: 2016-11-11 13:52:28.766122Z] Running create-virtualenv step. 05:52:28 INFO - Running pre-action listener: _resource_record_pre_action 05:52:28 INFO - Running main action method: create_virtualenv 05:52:28 INFO - Creating virtualenv /builds/slave/test/build/venv 05:52:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:52:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:52:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:52:28 INFO - Using real prefix '/usr' 05:52:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:52:29 INFO - Installing distribute.............................................................................................................................................................................................done. 05:52:31 INFO - Installing pip.................done. 05:52:31 INFO - Return code: 0 05:52:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:52:31 INFO - Reading from file tmpfile_stdout 05:52:31 INFO - Output received: 05:52:31 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:52:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:31 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 0x7f743f854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1171790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116e930>, '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 0x116f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116fcc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:52:31 INFO - Using env: {'DISPLAY': ':0', 05:52:31 INFO - 'HOME': '/home/cltbld', 05:52:31 INFO - 'LANG': 'en_US.UTF-8', 05:52:31 INFO - 'LANGUAGE': 'en_US:en', 05:52:31 INFO - 'LOGNAME': 'cltbld', 05:52:31 INFO - 'MAIL': '/var/mail/cltbld', 05:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:31 INFO - 'MOZ_NO_REMOTE': '1', 05:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:31 INFO - 'NO_EM_RESTART': '1', 05:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:31 INFO - 'PWD': '/builds/slave/test', 05:52:31 INFO - 'SHELL': '/bin/bash', 05:52:31 INFO - 'SHLVL': '1', 05:52:31 INFO - 'TERM': 'linux', 05:52:31 INFO - 'TMOUT': '86400', 05:52:31 INFO - 'USER': 'cltbld', 05:52:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 05:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:31 INFO - '_': '/tools/buildbot/bin/python'} 05:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:52:31 INFO - Cleaning up... 05:52:31 INFO - Return code: 0 05:52:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:31 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 0x7f743f854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1171790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116e930>, '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 0x116f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116fcc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:52:31 INFO - Using env: {'DISPLAY': ':0', 05:52:31 INFO - 'HOME': '/home/cltbld', 05:52:31 INFO - 'LANG': 'en_US.UTF-8', 05:52:31 INFO - 'LANGUAGE': 'en_US:en', 05:52:31 INFO - 'LOGNAME': 'cltbld', 05:52:31 INFO - 'MAIL': '/var/mail/cltbld', 05:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:31 INFO - 'MOZ_NO_REMOTE': '1', 05:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:31 INFO - 'NO_EM_RESTART': '1', 05:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:31 INFO - 'PWD': '/builds/slave/test', 05:52:31 INFO - 'SHELL': '/bin/bash', 05:52:31 INFO - 'SHLVL': '1', 05:52:31 INFO - 'TERM': 'linux', 05:52:31 INFO - 'TMOUT': '86400', 05:52:31 INFO - 'USER': 'cltbld', 05:52:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 05:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:31 INFO - '_': '/tools/buildbot/bin/python'} 05:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:31 INFO - Downloading/unpacking psutil>=3.1.1 05:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:52:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:34 INFO - Installing collected packages: psutil 05:52:34 INFO - Running setup.py install for psutil 05:52:34 INFO - building 'psutil._psutil_linux' extension 05:52:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:52:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:52:34 INFO - building 'psutil._psutil_posix' extension 05:52:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:52:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:52:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:34 INFO - Successfully installed psutil 05:52:34 INFO - Cleaning up... 05:52:34 INFO - Return code: 0 05:52:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:34 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 0x7f743f854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1171790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116e930>, '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 0x116f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116fcc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:52:34 INFO - Using env: {'DISPLAY': ':0', 05:52:34 INFO - 'HOME': '/home/cltbld', 05:52:34 INFO - 'LANG': 'en_US.UTF-8', 05:52:34 INFO - 'LANGUAGE': 'en_US:en', 05:52:34 INFO - 'LOGNAME': 'cltbld', 05:52:34 INFO - 'MAIL': '/var/mail/cltbld', 05:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:34 INFO - 'MOZ_NO_REMOTE': '1', 05:52:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:34 INFO - 'NO_EM_RESTART': '1', 05:52:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:34 INFO - 'PWD': '/builds/slave/test', 05:52:34 INFO - 'SHELL': '/bin/bash', 05:52:34 INFO - 'SHLVL': '1', 05:52:34 INFO - 'TERM': 'linux', 05:52:34 INFO - 'TMOUT': '86400', 05:52:34 INFO - 'USER': 'cltbld', 05:52:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 05:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:34 INFO - '_': '/tools/buildbot/bin/python'} 05:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:52:36 INFO - Installing collected packages: mozsystemmonitor 05:52:36 INFO - Running setup.py install for mozsystemmonitor 05:52:36 INFO - Successfully installed mozsystemmonitor 05:52:36 INFO - Cleaning up... 05:52:36 INFO - Return code: 0 05:52:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f743f854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1171790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116e930>, '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 0x116f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116fcc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:52:36 INFO - Using env: {'DISPLAY': ':0', 05:52:36 INFO - 'HOME': '/home/cltbld', 05:52:36 INFO - 'LANG': 'en_US.UTF-8', 05:52:36 INFO - 'LANGUAGE': 'en_US:en', 05:52:36 INFO - 'LOGNAME': 'cltbld', 05:52:36 INFO - 'MAIL': '/var/mail/cltbld', 05:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:36 INFO - 'MOZ_NO_REMOTE': '1', 05:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:36 INFO - 'NO_EM_RESTART': '1', 05:52:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:36 INFO - 'PWD': '/builds/slave/test', 05:52:36 INFO - 'SHELL': '/bin/bash', 05:52:36 INFO - 'SHLVL': '1', 05:52:36 INFO - 'TERM': 'linux', 05:52:36 INFO - 'TMOUT': '86400', 05:52:36 INFO - 'USER': 'cltbld', 05:52:36 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 05:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:36 INFO - '_': '/tools/buildbot/bin/python'} 05:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:37 INFO - Downloading/unpacking jsonschema==2.5.1 05:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:52:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:39 INFO - Downloading functools32-3.2.3-2.tar.gz 05:52:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:52:39 INFO - warning: no files found matching '*.txt' 05:52:39 INFO - no previously-included directories found matching 'build' 05:52:39 INFO - no previously-included directories found matching 'dist' 05:52:39 INFO - no previously-included directories found matching '.git*' 05:52:39 INFO - Installing collected packages: jsonschema, functools32 05:52:39 INFO - Running setup.py install for functools32 05:52:39 INFO - warning: no files found matching '*.txt' 05:52:39 INFO - no previously-included directories found matching 'build' 05:52:39 INFO - no previously-included directories found matching 'dist' 05:52:39 INFO - no previously-included directories found matching '.git*' 05:52:39 INFO - Successfully installed jsonschema functools32 05:52:39 INFO - Cleaning up... 05:52:39 INFO - Return code: 0 05:52:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:39 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 0x7f743f854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1171790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116e930>, '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 0x116f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116fcc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:52:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:52:39 INFO - Using env: {'DISPLAY': ':0', 05:52:39 INFO - 'HOME': '/home/cltbld', 05:52:39 INFO - 'LANG': 'en_US.UTF-8', 05:52:39 INFO - 'LANGUAGE': 'en_US:en', 05:52:39 INFO - 'LOGNAME': 'cltbld', 05:52:39 INFO - 'MAIL': '/var/mail/cltbld', 05:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:39 INFO - 'MOZ_NO_REMOTE': '1', 05:52:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:39 INFO - 'NO_EM_RESTART': '1', 05:52:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:39 INFO - 'PWD': '/builds/slave/test', 05:52:39 INFO - 'SHELL': '/bin/bash', 05:52:39 INFO - 'SHLVL': '1', 05:52:39 INFO - 'TERM': 'linux', 05:52:39 INFO - 'TMOUT': '86400', 05:52:39 INFO - 'USER': 'cltbld', 05:52:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 05:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:39 INFO - '_': '/tools/buildbot/bin/python'} 05:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:52:39 INFO - Cleaning up... 05:52:39 INFO - Return code: 0 05:52:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:39 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 0x7f743f854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1171790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116e930>, '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 0x116f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116fcc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:52:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:52:39 INFO - Using env: {'DISPLAY': ':0', 05:52:39 INFO - 'HOME': '/home/cltbld', 05:52:39 INFO - 'LANG': 'en_US.UTF-8', 05:52:39 INFO - 'LANGUAGE': 'en_US:en', 05:52:39 INFO - 'LOGNAME': 'cltbld', 05:52:39 INFO - 'MAIL': '/var/mail/cltbld', 05:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:39 INFO - 'MOZ_NO_REMOTE': '1', 05:52:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:39 INFO - 'NO_EM_RESTART': '1', 05:52:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:39 INFO - 'PWD': '/builds/slave/test', 05:52:39 INFO - 'SHELL': '/bin/bash', 05:52:39 INFO - 'SHLVL': '1', 05:52:39 INFO - 'TERM': 'linux', 05:52:39 INFO - 'TMOUT': '86400', 05:52:39 INFO - 'USER': 'cltbld', 05:52:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 05:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:39 INFO - '_': '/tools/buildbot/bin/python'} 05:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:39 INFO - Downloading/unpacking blobuploader==1.2.4 05:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:42 INFO - Downloading blobuploader-1.2.4.tar.gz 05:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:52:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:52:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:42 INFO - Downloading docopt-0.6.1.tar.gz 05:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:52:42 INFO - Installing collected packages: blobuploader, requests, docopt 05:52:42 INFO - Running setup.py install for blobuploader 05:52:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:52:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:52:42 INFO - Running setup.py install for requests 05:52:43 INFO - Running setup.py install for docopt 05:52:43 INFO - Successfully installed blobuploader requests docopt 05:52:43 INFO - Cleaning up... 05:52:43 INFO - Return code: 0 05:52:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:43 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 0x7f743f854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1171790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116e930>, '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 0x116f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116fcc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:52:43 INFO - Using env: {'DISPLAY': ':0', 05:52:43 INFO - 'HOME': '/home/cltbld', 05:52:43 INFO - 'LANG': 'en_US.UTF-8', 05:52:43 INFO - 'LANGUAGE': 'en_US:en', 05:52:43 INFO - 'LOGNAME': 'cltbld', 05:52:43 INFO - 'MAIL': '/var/mail/cltbld', 05:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:43 INFO - 'MOZ_NO_REMOTE': '1', 05:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:43 INFO - 'NO_EM_RESTART': '1', 05:52:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:43 INFO - 'PWD': '/builds/slave/test', 05:52:43 INFO - 'SHELL': '/bin/bash', 05:52:43 INFO - 'SHLVL': '1', 05:52:43 INFO - 'TERM': 'linux', 05:52:43 INFO - 'TMOUT': '86400', 05:52:43 INFO - 'USER': 'cltbld', 05:52:43 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 05:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:43 INFO - '_': '/tools/buildbot/bin/python'} 05:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:43 INFO - Running setup.py (path:/tmp/pip-UAt7z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:43 INFO - Running setup.py (path:/tmp/pip-4qD0Nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:43 INFO - Running setup.py (path:/tmp/pip-NAY5Sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:43 INFO - Running setup.py (path:/tmp/pip-DDB0Er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:44 INFO - Running setup.py (path:/tmp/pip-Q0GtzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:44 INFO - Running setup.py (path:/tmp/pip-N_9ZOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:44 INFO - Running setup.py (path:/tmp/pip-aj9nZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:44 INFO - Running setup.py (path:/tmp/pip-NoxmxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:44 INFO - Running setup.py (path:/tmp/pip-k9IyQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:44 INFO - Running setup.py (path:/tmp/pip-QTQzzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:44 INFO - Running setup.py (path:/tmp/pip-KLA9E1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:44 INFO - Running setup.py (path:/tmp/pip-u0AeEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:44 INFO - Running setup.py (path:/tmp/pip-D6qEXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:44 INFO - Running setup.py (path:/tmp/pip-LnprmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:44 INFO - Running setup.py (path:/tmp/pip-CGcNjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:44 INFO - Running setup.py (path:/tmp/pip-pQTcng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:44 INFO - Running setup.py (path:/tmp/pip-HUUnru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:52:44 INFO - Running setup.py install for manifestparser 05:52:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Running setup.py install for mozcrash 05:52:45 INFO - Running setup.py install for mozdebug 05:52:45 INFO - Running setup.py install for mozdevice 05:52:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Running setup.py install for mozfile 05:52:45 INFO - Running setup.py install for mozhttpd 05:52:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Running setup.py install for mozinfo 05:52:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Running setup.py install for mozInstall 05:52:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Running setup.py install for mozleak 05:52:45 INFO - Running setup.py install for mozlog 05:52:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Running setup.py install for moznetwork 05:52:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:52:46 INFO - Running setup.py install for mozprocess 05:52:46 INFO - Running setup.py install for mozprofile 05:52:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:52:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:52:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:52:46 INFO - Running setup.py install for mozrunner 05:52:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:52:46 INFO - Running setup.py install for mozscreenshot 05:52:46 INFO - Running setup.py install for moztest 05:52:46 INFO - Running setup.py install for mozversion 05:52:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:52:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:52:46 INFO - Cleaning up... 05:52:46 INFO - Return code: 0 05:52:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:46 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 0x7f743f854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1171790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116e930>, '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 0x116f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116fcc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:52:46 INFO - Using env: {'DISPLAY': ':0', 05:52:46 INFO - 'HOME': '/home/cltbld', 05:52:46 INFO - 'LANG': 'en_US.UTF-8', 05:52:46 INFO - 'LANGUAGE': 'en_US:en', 05:52:46 INFO - 'LOGNAME': 'cltbld', 05:52:46 INFO - 'MAIL': '/var/mail/cltbld', 05:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:46 INFO - 'MOZ_NO_REMOTE': '1', 05:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:46 INFO - 'NO_EM_RESTART': '1', 05:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:46 INFO - 'PWD': '/builds/slave/test', 05:52:46 INFO - 'SHELL': '/bin/bash', 05:52:46 INFO - 'SHLVL': '1', 05:52:46 INFO - 'TERM': 'linux', 05:52:46 INFO - 'TMOUT': '86400', 05:52:46 INFO - 'USER': 'cltbld', 05:52:46 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 05:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:46 INFO - '_': '/tools/buildbot/bin/python'} 05:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:46 INFO - Running setup.py (path:/tmp/pip-TSJK4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:47 INFO - Running setup.py (path:/tmp/pip-If88uJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:47 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)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:47 INFO - Running setup.py (path:/tmp/pip-Vkm9VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:47 INFO - Running setup.py (path:/tmp/pip-2XOIis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:47 INFO - Running setup.py (path:/tmp/pip-EFgESl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:47 INFO - Running setup.py (path:/tmp/pip-JzQmDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:47 INFO - Running setup.py (path:/tmp/pip-u64_G5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:47 INFO - Running setup.py (path:/tmp/pip-xc21PH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:47 INFO - Running setup.py (path:/tmp/pip-D1P_um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:47 INFO - Running setup.py (path:/tmp/pip-SNsWh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:47 INFO - Running setup.py (path:/tmp/pip-4s5dfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:47 INFO - Running setup.py (path:/tmp/pip-fulBox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:47 INFO - Running setup.py (path:/tmp/pip-i_yx3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:47 INFO - Running setup.py (path:/tmp/pip-i8shbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:47 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)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:47 INFO - Running setup.py (path:/tmp/pip-qcBvm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:48 INFO - Running setup.py (path:/tmp/pip-KuFUai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:48 INFO - Running setup.py (path:/tmp/pip-tDruEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:52:48 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)) 05:52:48 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)) 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:52:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:50 INFO - Downloading blessings-1.6.tar.gz 05:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:52:50 INFO - Installing collected packages: blessings 05:52:50 INFO - Running setup.py install for blessings 05:52:50 INFO - Successfully installed blessings 05:52:50 INFO - Cleaning up... 05:52:50 INFO - Return code: 0 05:52:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:52:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:50 INFO - Reading from file tmpfile_stdout 05:52:50 INFO - Current package versions: 05:52:50 INFO - argparse == 1.2.1 05:52:50 INFO - blessings == 1.6 05:52:50 INFO - blobuploader == 1.2.4 05:52:50 INFO - docopt == 0.6.1 05:52:50 INFO - functools32 == 3.2.3-2 05:52:50 INFO - jsonschema == 2.5.1 05:52:50 INFO - manifestparser == 1.1 05:52:50 INFO - mozInstall == 1.12 05:52:50 INFO - mozcrash == 1.0 05:52:50 INFO - mozdebug == 0.1 05:52:50 INFO - mozdevice == 0.48 05:52:50 INFO - mozfile == 1.2 05:52:50 INFO - mozhttpd == 0.7 05:52:50 INFO - mozinfo == 0.9 05:52:50 INFO - mozleak == 0.1 05:52:50 INFO - mozlog == 3.4 05:52:50 INFO - moznetwork == 0.27 05:52:50 INFO - mozprocess == 0.23 05:52:50 INFO - mozprofile == 0.28 05:52:50 INFO - mozrunner == 6.13 05:52:50 INFO - mozscreenshot == 0.1 05:52:50 INFO - mozsystemmonitor == 0.3 05:52:50 INFO - moztest == 0.7 05:52:50 INFO - mozversion == 1.4 05:52:50 INFO - psutil == 3.1.1 05:52:50 INFO - requests == 1.2.3 05:52:50 INFO - wsgiref == 0.1.2 05:52:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:50 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 0x7f743f854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1171790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116e930>, '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 0x116f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116fcc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:52:50 INFO - Using env: {'DISPLAY': ':0', 05:52:50 INFO - 'HOME': '/home/cltbld', 05:52:50 INFO - 'LANG': 'en_US.UTF-8', 05:52:50 INFO - 'LANGUAGE': 'en_US:en', 05:52:50 INFO - 'LOGNAME': 'cltbld', 05:52:50 INFO - 'MAIL': '/var/mail/cltbld', 05:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:50 INFO - 'MOZ_NO_REMOTE': '1', 05:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:50 INFO - 'NO_EM_RESTART': '1', 05:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:50 INFO - 'PWD': '/builds/slave/test', 05:52:50 INFO - 'SHELL': '/bin/bash', 05:52:50 INFO - 'SHLVL': '1', 05:52:50 INFO - 'TERM': 'linux', 05:52:50 INFO - 'TMOUT': '86400', 05:52:50 INFO - 'USER': 'cltbld', 05:52:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 05:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:50 INFO - '_': '/tools/buildbot/bin/python'} 05:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:52:50 INFO - Cleaning up... 05:52:50 INFO - Return code: 0 05:52:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f743f854f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1171790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116e930>, '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 0x116f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116fcc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:52:50 INFO - Using env: {'DISPLAY': ':0', 05:52:50 INFO - 'HOME': '/home/cltbld', 05:52:50 INFO - 'LANG': 'en_US.UTF-8', 05:52:50 INFO - 'LANGUAGE': 'en_US:en', 05:52:50 INFO - 'LOGNAME': 'cltbld', 05:52:50 INFO - 'MAIL': '/var/mail/cltbld', 05:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:50 INFO - 'MOZ_NO_REMOTE': '1', 05:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:50 INFO - 'NO_EM_RESTART': '1', 05:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:50 INFO - 'PWD': '/builds/slave/test', 05:52:50 INFO - 'SHELL': '/bin/bash', 05:52:50 INFO - 'SHLVL': '1', 05:52:50 INFO - 'TERM': 'linux', 05:52:50 INFO - 'TMOUT': '86400', 05:52:50 INFO - 'USER': 'cltbld', 05:52:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 05:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:50 INFO - '_': '/tools/buildbot/bin/python'} 05:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:52:51 INFO - Cleaning up... 05:52:51 INFO - Return code: 0 05:52:51 INFO - Running post-action listener: _resource_record_post_action 05:52:51 INFO - Running post-action listener: _start_resource_monitoring 05:52:51 INFO - Starting resource monitoring. 05:52:51 INFO - [mozharness: 2016-11-11 13:52:51.079377Z] Finished create-virtualenv step (success) 05:52:51 INFO - [mozharness: 2016-11-11 13:52:51.079885Z] Running install step. 05:52:51 INFO - Running pre-action listener: _resource_record_pre_action 05:52:51 INFO - Running main action method: install 05:52:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:51 INFO - Reading from file tmpfile_stdout 05:52:51 INFO - Detecting whether we're running mozinstall >=1.0... 05:52:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:52:51 INFO - Reading from file tmpfile_stdout 05:52:51 INFO - Output received: 05:52:51 INFO - Usage: mozinstall [options] installer 05:52:51 INFO - Options: 05:52:51 INFO - -h, --help show this help message and exit 05:52:51 INFO - -d DEST, --destination=DEST 05:52:51 INFO - Directory to install application into. [default: 05:52:51 INFO - "/builds/slave/test"] 05:52:51 INFO - --app=APP Application being installed. [default: firefox] 05:52:51 INFO - mkdir: /builds/slave/test/build/application 05:52:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:53:08 INFO - Reading from file tmpfile_stdout 05:53:08 INFO - Output received: 05:53:08 INFO - /builds/slave/test/build/application/firefox/firefox 05:53:08 INFO - Running post-action listener: _resource_record_post_action 05:53:08 INFO - [mozharness: 2016-11-11 13:53:08.228692Z] Finished install step (success) 05:53:08 INFO - [mozharness: 2016-11-11 13:53:08.228934Z] Running run-tests step. 05:53:08 INFO - Running pre-action listener: _resource_record_pre_action 05:53:08 INFO - Running main action method: run_tests 05:53:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:53:08 INFO - Python 2.7.3 05:53:08 INFO - Return code: 0 05:53:08 INFO - grabbing minidump binary from tooltool 05:53: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')]} 05:53:08 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 0x116e930>, '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 0x116f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116fcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:53:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:53:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:53:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:53:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:08 INFO - Return code: 0 05:53:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:53:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:53:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:53:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:53:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:53:08 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/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:53:08 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/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:53:08 INFO - Using env: {'DISPLAY': ':0', 05:53:08 INFO - 'HOME': '/home/cltbld', 05:53:08 INFO - 'LANG': 'en_US.UTF-8', 05:53:08 INFO - 'LANGUAGE': 'en_US:en', 05:53:08 INFO - 'LOGNAME': 'cltbld', 05:53:08 INFO - 'MAIL': '/var/mail/cltbld', 05:53:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:53:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:08 INFO - 'MOZ_NO_REMOTE': '1', 05:53:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:08 INFO - 'NO_EM_RESTART': '1', 05:53:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:08 INFO - 'PWD': '/builds/slave/test', 05:53:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:53:08 INFO - 'SHELL': '/bin/bash', 05:53:08 INFO - 'SHLVL': '1', 05:53:08 INFO - 'TERM': 'linux', 05:53:08 INFO - 'TMOUT': '86400', 05:53:08 INFO - 'USER': 'cltbld', 05:53:08 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136', 05:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:08 INFO - '_': '/tools/buildbot/bin/python'} 05:53:08 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/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:53:08 INFO - mozversion application_buildid: 20161111030203 05:53:08 INFO - mozversion application_changeset: d38d06f85ef59c5dbb5d4a1a8d895957a78714de 05:53:08 INFO - mozversion application_display_name: Nightly 05:53:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:08 INFO - mozversion application_name: Firefox 05:53:08 INFO - mozversion application_remotingname: firefox 05:53:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:53:08 INFO - mozversion application_vendor: Mozilla 05:53:08 INFO - mozversion application_version: 52.0a1 05:53:08 INFO - mozversion platform_buildid: 20161111030203 05:53:08 INFO - mozversion platform_changeset: d38d06f85ef59c5dbb5d4a1a8d895957a78714de 05:53:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:53:08 INFO - mozversion platform_version: 52.0a1 05:53:08 INFO - using testdate: 1478872388 05:53:08 INFO - actual date: 1478872388 05:53:08 INFO - starting webserver on 'localhost:32873' 05:53:08 INFO - SUITE-START | Running 2 tests 05:53:08 INFO - TEST-START | dromaeo_css 05:53:08 INFO - operating with platform_type : linux_ 05:53:08 INFO - Initialising browser for dromaeo_css test... 05:53:08 INFO - TEST-INFO | started process 1773 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb19_HI/profile http://localhost:32873/getInfo.html) 05:53:12 INFO - PROCESS | 1773 | __metrics Screen width/height:1600/1200 05:53:12 INFO - PROCESS | 1773 | colorDepth:24 05:53:12 INFO - PROCESS | 1773 | Browser inner width/height: 1024/697 05:53:12 INFO - PROCESS | 1773 | __metrics 05:53:13 ERROR - PROCESS | 1773 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 05:53:14 INFO - TEST-INFO | 1773: exit 0 05:53:14 INFO - Browser initialized. 05:53:14 INFO - Running cycle 1/1 for dromaeo_css test... 05:53:14 INFO - TEST-INFO | started process 1897 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb19_HI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:26 INFO - PROCESS | 1897 | RSS: Main: 185761792 05:53:26 INFO - PROCESS | 1897 | 05:54:16 INFO - PROCESS | 1897 | 1478872455996 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:56:27 INFO - PROCESS | 1897 | Cycle 1(1): loaded http://localhost:32873/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32873/tests/dromaeo/cssquery-ext.html) 05:56:28 INFO - PROCESS | 1897 | RSS: Main: 196734976 05:56:28 INFO - PROCESS | 1897 | 05:59:31 INFO - PROCESS | 1897 | Cycle 1(1): loaded http://localhost:32873/tests/dromaeo/cssquery-ext.html (next: http://localhost:32873/tests/dromaeo/cssquery-jquery.html) 05:59:31 INFO - PROCESS | 1897 | RSS: Main: 196370432 05:59:31 INFO - PROCESS | 1897 | 06:02:33 INFO - PROCESS | 1897 | Cycle 1(1): loaded http://localhost:32873/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32873/tests/dromaeo/cssquery-mootools.html) 06:02:34 INFO - PROCESS | 1897 | RSS: Main: 198328320 06:02:34 INFO - PROCESS | 1897 | 06:05:36 INFO - PROCESS | 1897 | Cycle 1(1): loaded http://localhost:32873/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32873/tests/dromaeo/cssquery-prototype.html) 06:05:36 INFO - PROCESS | 1897 | RSS: Main: 195018752 06:05:36 INFO - PROCESS | 1897 | 06:08:39 INFO - PROCESS | 1897 | Cycle 1(1): loaded http://localhost:32873/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32873/tests/dromaeo/cssquery-yui.html) 06:08:40 INFO - PROCESS | 1897 | RSS: Main: 198623232 06:08:40 INFO - PROCESS | 1897 | 06:11:42 INFO - PROCESS | 1897 | Cycle 1(1): loaded http://localhost:32873/tests/dromaeo/cssquery-yui.html (next: http://localhost:32873/tests/dromaeo/cssquery-dojo.html) 06:11:42 INFO - PROCESS | 1897 | RSS: Main: 198574080 06:11:42 INFO - PROCESS | 1897 | 06:11:42 INFO - PROCESS | 1897 | __start_tp_report 06:11:42 INFO - PROCESS | 1897 | _x_x_mozilla_page_load 06:11:42 INFO - PROCESS | 1897 | _x_x_mozilla_page_load_details 06:11:42 INFO - PROCESS | 1897 | |i|pagename|runs| 06:11:42 INFO - PROCESS | 1897 | |0;dojo.html;3048.253177971397;3050.9847450762772;3068.079576127161;3079.3379423423958;3089.799163054401;5302.363716354033;5414.106672399054;5440.3743569489525;5486.698231597261;5531.474509921561;5325.387580428252;5396.811111611094;5411.675299482034;5476.58925580582;5483.725813709319;4812.639052071091;4826.276058591205;4924.901501969976;4943.1102401567705;4986.650934434591;4815.783289751952;4879.9512004880025;4972.428170760372;4980.078685443204;5000.924986125211;4764.285357196413;4771.570558649738;4797.71213727174;4824.638152138604;4855.805767769302;4847.684900481458;4858.732769697665;4860.781264843091;4871.561559459666;4889.437714662824;4661.09108723799;4736.242201247784;4824.951750482521;4830.420349558076;4844.346013288196;5361.839144825662;5400.162974738922;5403.405625381205;5408.864778380533;5455.18172274158;5810.070388737781;5811.651300921958;5812.651240925558;5820.301563812327;5822.82531524055;5538.944610553924;5650.152477128422;5833.358330583633;5864.296284445851;5865.882682346371;5344.893102137974;5346.732663366816;5352.277442545284;5356.625036247464;5375.3012108425655;5779.075347944393;5784.074548072288;5818.8254352369495;5869.735861886225;5951.5238780897425;5647.774089036475;5659.349174844863;5669.829905102771;5675.489205971482;5681.0910254359105;5716.028275193227;5719.056355701263;5741.110127930177;5752.654840709571;5754.769809207585;5676.716164191774;5691.516221121168;5704.11586204139;5764.567657425626;5777.0467872801355;5810.7966221182905;5819.330776960619;5824.854378640568;5825.0388685866355;5865.384134665884;4363.301871700576;4373.387725718402;4389.934150987738;4413.7572433515825;4420.8673739787855;3831.1954489556947;3859.6526312631436;3860.1121741999495;3902.473166122537;3924.489816323917;5553.111502159635;5555;5620.57845661577;5633.408492108351;5644.125160600113;5860.794872179454;5862.472377486047;5879.2944846618675;5900.43945825146;5937.287525496881;5415.756290966916;5455.781768729285;5462.5083742462575;5613.803516876889;5615.410381909841;4959.975200123977;4964.429090654621;5000.1249781288125;5033.672811267256;5051.747412629354;5920.8815823684145;5930.377310382348;5967.16459695643;5976.372480889618;6012.248468941382;5910.881782364243;5946.167536544801;5993.820185394445;5997.010493268736;6007.309159446545;5802.100674395476;5919.6152250103605;5923.7926672566255;6007.429294217042;6011.549133815069;5657.981563318642;5667.4615911488345;5704.286964129484;5771.769129234784;5781.479666830005;5837.066069429041;5838.591298609056;5844.853878653068;5845.532357411312;5911.3201981772645;5660.29246344207;5710.971445142914;5720.45655662728;5725.914111288417;5735.54115670737;5578.581606379456;5600.8879822402505;5631.099024156116;5690.317161940594;5726.914096288476;5496.697681627549;5573.470520300565;5608.803691870765;5652.830415087554;5690.487856092972;5763.884722305615;5813.593048486735;5818.650880947157;5818.970905145447;5854.180414742024;5579;5604.523615492729;5620.8032718856275;5650.830475085754;5666.093425051972 06:11:42 INFO - PROCESS | 1897 | |1;ext.html;559.815260963882;566.0829456280825;572.5734327925696;575.8301301116171;603.8912995660783;31749.841250793743;40373.59626403735;40817.97955051121;41358.17283654325;44692;43045.35431968515;43496.565034349645;43497;43541.7822910885;43635.563644363545;8439.451435656694;8669.913300866974;8683.609237584293;8690.174433428845;8699.39104262702;8475.279601233902;8529.232369086782;8569.485830850137;8571.657133714643;8580.570971451434;8472.19514146155;8534.530600816952;8548.230659240668;8555.743327700147;8570;8484.575771211477;8496.490210587353;8511.829763404729;8556.315494760403;8594.054653988056;8458.577071146417;8515.74452766418;8544.957275213646;8550.40147189697;8557.400981931267;40393.798031009654;40702;40727.592724072674;41055.79472102621;41060;3503.9824800876086;3533.6643018913164;3659.469376940329;3665.303592317478;3665.688416484602;30372.088837334693;30832.229194270098;31199;31347.529787053212;31633;4114.326780554275;4133.483314585676;4194.30793919003;4214.894627634334;4296;306772;307344;308246;308623;309509;55074.724626376614;55200;55241;55428.1915026574;55718.44281557214;59249.40750592439;59556.404435955956;59985;60253.39746602566;60568.09147862786;16824.831751682326;17028.48914532566;17070.317187312616;17087.829121708623;17168;12554.928436807824;12572.622821315375;12584.37078146089;12606.684832879067;12608.81086783699;16982.575435613962;17389.739153912447;17404.564885877953;17523.73714394285;17530;6329.556931014785;6357.268914074941;6360.681965901686;6655.6339401332425;6691.7323307068145;867.6616119713317;901.7024381953939;931.6040682709821;959.5298303831072;969.9515024248759;29268.560971585444;31060.598540870604;31080.84459577733;31201.375972480422;31386.68613313883;1044.300318786415;1048.1771809129796;1104.6851647280487;1116.268843907242;1144.1533265383723;15504.379824807107;16164.27260773268;16377.344906203856;16440.019306075854;16480.83519164793;457234;459812;462991;463533;463697;55987;56011;56368.718156408955;56484;56597.71701141468;1220.7863623865965;1265.6329664397406;1288.5103660608909;1301.8828305452555;1319.940602672882;28782.568261475677;32005.35989280248;32338.514922276656;33448.498272525445;33806.32387352288;54430;54501.72749136229;55062.449375507334;55122.417042892084;55173.44826551683;440040;440732;441993;443682;444439;38766;39608;40032.39951400673;40351;40492.797536012135;45971.540284596726;45984.770076149405;46452.30321545112;47275;47686.523134769595;38285.4257186148;38371.616283837924;38573.2285354297;39818.60181398149;40635.59364406318;37902.24195516019;38577.80711096426;38587.807060964515;40341.59658403378;40479.1904161921;34431;35512.289754204256;37449.251014980095;38689.41965870458;39595.80202098971;33258.83370583229;35529;35759.46360804642;35782.74760383374;36020.4596931041;26947.73052269452;27576.724232757417;27612.30969225705;27657;27979.58030629583 06:11:42 INFO - PROCESS | 1897 | |2;jquery.html;389.38671592242207;391.37380191693313;396.1502576972395;396.9622885825846;428.4473029791569;16402.09788461634;16741.16294185292;17630.294788208474;19113.713294300596;19126.52183695408;11148.498317575708;12418.751624967495;12612.936935315334;17568.29726810926;19223.231070757152;5015.874603134915;5204;5217.34783152106;5217.973910130463;5234.031704134728;4900.681455705386;5189.195674670414;5206.45332240115;5215.217717342391;5219.973900130494;5176.922346164811;5578.553715702755;5875.559333050017;5882.823515294526;5966.343702192756;5810.448007439287;5840;5852.268466441695;5891.410858914117;5946.286445626552;5689.772409103631;5742.339630942453;5758.654480731169;5763.452472015152;5771.826845194651;13816.240106794123;14185.148891066568;22025.449363765874;22843.54312913749;23124.306270811903;2287.3481057898584;2329.860208387502;2426.7694569015916;2630.658014458127;2642.616820561027;9909.662195603645;10021.248406369552;10248.897511024868;10400.271980961335;10541.156707463384;1829.5426143464133;1889.3670620342202;1894.4411398637435;1901.995503650793;2011.1251605551631;73565;77544.61227693825;80281;82022.58988705078;82402.58798706028;10206.183505319557;10351.171906247482;10492.632757853438;11251.887481125084;11385.601503947322;15293.541193764206;15367.538973830802;15521.689566208612;15559.29983150761;15575.299111540007;7546.434017448713;7802.921970780333;7822;7975.4018448615425;8025.2376024278765;7410;7526.172121066678;7530;7681.500702454323;7686.192949740309;4626.496388673694;4663.930041049387;4753.405824271966;4766.95233047672;4777.95222047775;1895.2563641449624;1979.2281010405952;1987.7614686237744;2055.095757866534;2095.549456866781;872.2629378175432;878.3368556739748;956.5360800011989;1004.2116938203475;1019.5106348952544;17509.299628014738;17932.193051312723;18379.90810045968;18572;18873.207045330946;948.3314263444255;973.4694591447678;994.7662299359645;1007.5314978534869;1029.6087486755134;10007.949960250153;10348.637797677045;10439.791204175874;10555.208359373079;10562.894371056345;322459;325704;325981;424348;424961;88833.55583222043;92711.53644231871;95048;97117;97408;1009.3590569987964;1036.5594622285498;1072.2172813845937;1084.734240111162;1090.4547726136932;16723.33106675768;16970.830291697417;17420.30318787234;17630.559236019202;17767.55581110431;40648;42418.78790606027;43714.34428483512;44190.33714494221;44262;60242.39757602368;60865.69567152136;61280.69359653173;62558;64461;8399.622017009127;8435.613480989974;8465.322774178174;8657.783555411164;9086.500242486727;9883.654072107442;12948.28784416866;13495.932520337336;13605.455781768618;13662.521811736542;11191.496382662637;11812.3503207321;12068.939655301667;12093.395330233629;12145.878541214828;11181.496832642388;11339.149563782585;11345.319280843176;11468.713282168013;11485.770284594095;6393.8721225576155;8133.633986470742;11557;11684.88315116872;11875.109366797698;8478.618462169094;8683.82632347337;11813.409329533317;11822;12007.879921201025;11649.767004660029;12293.815592765937;12313.13808033429;12341.259524428562;12966.675833104247 06:11:42 INFO - PROCESS | 1897 | |3;mootools.html;1454.3528129982155;1465.2307538542264;1605.2214675882194;1702.429686055173;1715.1595718098129;7368.668409921553;7603.277688619586;8049.8792518112205;8561.486310821356;8573.485590864537;7924.762257132281;8176.264136227738;8181.263686268235;8393.24460798528;8407.453515521487;2232.910683572655;2264.501809601885;2284.805791507724;2285.5086156476355;2288.6567014947723;2244.068711484732;2272.409173614864;2318.13070098713;2322.9767702323015;2337.5792357375667;2281.5094754627753;2290.656401539774;2320.2459200759736;2361.8464799787957;2365.6096744037213;2234.229190929135;2241.5628952354296;2259.0399080390935;2264.4565304326925;2276.4081338852016;2228.186711850163;2249.044156233594;2257.142285931352;2258.6160352740076;2262.4230821140504;8438.831223375499;8454.830903381899;8516.403851730382;8535.140727856176;8605.870911936327;5104.183330667075;5208.348956380452;5224.320838290998;5249.081410753141;5250.606204534637;3175.984120079408;3205.727513161384;3548.7338449616122;3549.716022718176;3561.145325121978;1112.3437172068518;1117.664700589828;1157.6816375496721;1173.9941300293528;1176.4353110507004;11706.882931170665;11823.231489953125;11923.761524769456;11938.582149624808;11955.880441195564;4415.205263052681;4619.838305659286;4641.535846415331;4719.882002949954;4727.456342520654;9935.602575896883;9945.403275803475;9960.601575936882;9999.50002499872;10013.749656258506;5307.203919412119;5318.122509785842;5330.120530112566;5352.678839269656;5393.2449457076045;3984.601539845992;4738.241881298975;4805.975970120127;4864.489228630943;4918.139325618003;3745.7003439725304;3799.2021675447913;3834.9041273968373;3887.669548088444;3926.509186351706;1274.1272228523492;1296.572131196703;1300.1938797945334;1301.4989229146847;1319.9802002969964;947.8672985781996;957.4781743949565;981.5337714585658;983.6753871222479;993.6820217530321;5687.175359572839;5786.623869448473;5842.094475356242;5892.322382925932;6049.879002420015;445.4298497922664;451.14282862561396;458.15013150605813;470.2335193634354;477.067333363274;3941.3890846918775;3996.9400458993136;4004.4994375703036;4059.330210515291;4092.9181416371507;10217.795644087077;10407.531661075118;10611.363318200933;10619.256652034283;10624.575016999388;10480.580776768997;10520;10529;10574.89425105739;10592.205584581186;7491.625418729151;7868.488548244346;7982.121966583672;7982.321502672338;7999.3200577950365;5618.85952851182;5728.627639203439;5729.3984131665575;5740.942590574041;5743.856403589776;9533.47565883883;9563.665271715456;9585.952070239604;9706.660266890907;9727.610895564381;9183.632654693738;9504.144626983605;9508.619655213713;9715;9744.269179811401;6642.335766423319;6795.38841504267;7400.629968501446;7481.551106933602;7633.1985141559335;8010.279074883289;8365.24712775853;8383.245507904074;8387.580620968805;8400.369972252227;7386.224446433047;7465.141508726349;7481.476296659399;7607.087149542091;7613.733519326797;7183.676734546853;7309.451791115794;7310.415166786751;7364.668589913574;7387.667554959932;6867.931320686929;7001.124859392576;7010.123734533184;7025.192102908231;7049.330313620198;5094.465081166424;5120.513551212629;5179.559737422362;5188.507091826271;5420.295361602966;4847.927281090716;5074.492550745043;5146.073706732824;5204.5315921565725;5342.599305052215 06:11:42 INFO - PROCESS | 1897 | |4;prototype.html;337.5679130712687;341.17605981554544;348.14530328044646;351.89443167049876;353.2934131736527;5414.186247607052;5467.031868527327;5476.972615136919;5492.615516913813;5514.310711161105;5365.543928766059;5369.543588794957;5371.81198658047;5387.757550910209;5393.2449457076045;3676.3015027144756;3989.521257449103;4070.1277412390336;4105.624615753711;4178.289690752579;4151.647109995654;4157.48031496063;4159.3968874513175;4162.771047592381;4166.479190101238;4156.314208155651;4158.667306615479;4161.563035881234;4164.750114993095;4166.791660416982;4036.2734707752593;4067.9186416271805;4146.896327591804;4164.68764842638;4168.791560421982;3619.5837478690023;3620.529331186955;3642.6175251598465;3651.5070465487083;3661.6521430464063;5211.24436956643;5241.8165364212455;5267.183586544092;5269.235960785703;5276.709780962045;4834.492378300263;4845.660803743739;4864.902701945941;4874.7562621868765;4892.486288939681;5378.327709036371;5640.351359593658;5662.207290979266;5669.177969194444;5677.460641239076;4067.633912947849;4073.226087043482;4075.6331930126134;4083.9591604083876;4089.591040895916;5647.989927151727;5841.678707671076;5852.239208902815;5879.441453061952;5880.294364676223;4189.7695626740215;4254.489461264668;4261.850835220753;4269.23153832307;4278.486581610165;4311.159323931804;4325.437693099877;4351.564843515623;4355.2813785725;4357.8669545917655;4621.976890115528;4853.878653033702;4894.975525122351;4906.705597664151;4913.459519452857;5624.91562626561;5649.604527683023;5657.161422537692;5710.229119068873;5723.5691077230695;1448.9205541871163;1451.75320195567;1453.8764205042478;1454.3818876977243;1457.7594696874896;963.1235575626147;1006.9295149339622;1015.7816069545083;1026.14829691356;1030.7526193713454;5219.478052194826;5233.921491177635;5244.770972336742;5287.365516138088;5289.841304760864;5576.1356989666665;5577.637453565505;5591.6365436246515;5591.804286849941;5607.383187849333;5006.774695138727;5136.666116702402;5241.475852414805;5259.474052594786;5272.815451459181;2973.7769667274606;2983.224361665939;2993.760499160062;2994.1616347422755;2995.1164406499697;5653.519450846642;5691.573132015115;5720.48515633595;5738.225339579187;5778.006587727227;5689.9146512802345;5983.940160598426;5991.610545314541;6018.428249316308;6047;5970.462658360769;5989.730462129215;6007.27912650476;6073.360192748021;6075.483583895419;5706.28671416073;5867.354590995073;5880.235569375954;5924.763009479572;5932.317783454958;5739.483446489836;5802.738876750641;5816.1857339973285;5824.21373114641;5842.269716285465;5818.865321262313;5963.821085367446;6011.6693581853415;6050.485708714633;6050.727717252822;4104.897377565465;4123.628873401408;4124.13393187422;4133.400656904792;4141.8964525887095;5745.253117094918;5867.6772777497645;5880.735366908585;5891.587588868738;5907.438793314628;5665.971670141623;5687.687177205128;5696.174054762119;5719.885602287848;5741.311042674905;5700.600957932905;5725.652482482163;5729.656220626775;5741.5406767459335;5743;5501.642393244426;5624.606277560531;5652.943470565242;5656.038473459439;5662.886742265214;5713.714314284186;5719.256496655408;5736.913946290892;5751.626144300607;5756.481916627524;5615.298087739033;5627.493525582717;5633.971830140823;5635.408282130317;5646.221440246473 06:11:42 INFO - PROCESS | 1897 | |5;yui.html;719.9964000179998;728.275366010819;739.79285799976;752.1801236652049;768.8462307538492;13674.658133546654;14434.13395196289;14583.489577864777;14787.186704731235;14978.400863965428;12799.104062715614;13461.798073028887;13599.660008499792;13616.659583510418;13624;659.3406593406605;775.0621747685279;785.9135495095535;789.9328557072656;790.328221012138;785.1089013969129;785.3403141361256;786.9016372953381;787.5432249295395;788.787027502574;805.3355981315439;806.3065763443434;806.6894245715383;809.017044291186;810.8743144812563;807.6567458830003;807.858624740668;807.907090684573;809.5749731391008;810.2059981218409;589.2751915144396;593.6438137117738;593.7239183779564;594.0999385930319;595.511680422054;12305.26168429897;12672.049596280223;12676.95979712098;12787.936060319731;12800.80798788019;11334.659960201207;11690.357030363326;11765.529378824922;11843.46704398304;12084.697882552919;9689.32174747768;9833.21334293262;9943.154831839302;10279.743006424824;10285.9485702571;3460.8269586520823;3507.1232191952013;3529.6470352964757;3547.52108465359;3558.2349794794245;51994.7400263;53070.46929530694;53661;59993.001049842875;60486.697566512325;10124.190064794946;10249.180065594735;10265.538050787733;10291.639792607222;10538.315009524356;18935.242590296235;18943.62112757737;18994.810051899305;19129.713054304197;19151.425457236306;7833.764987050397;7950.602469876483;8060.919390806017;8085.191480851868;8197.098319184885;4352.564743525622;4396.538363471789;4436.0462500562535;4461.330800379904;4502.279635258408;3445.4831775233915;3485.076454739496;3536.8231588420476;3556.3776339140545;3571.5357003589365;595.9940400595939;616.9352218017133;617.0559044661675;628.2398298059308;645.8449972006779;691.5021184746975;702.4064665357764;708.1820497325597;708.4757279613152;729.1032030602389;8296.502209867427;8601.179249965273;8712.651493940171;8731.083236260229;8756.693515726918;616.4205646692185;616.4852348289229;640.6700549217157;678.59284429342;680.1396233764292;4217.388478670576;4374.759388233678;4452.5992660660695;4456.844010459618;4492.213862574102;54763.72618136964;57661.423385766444;88669.55665221633;91553.54223228841;94349;58553.70723146357;60166.69916650389;69795;83128;84139;63833.68083159647;64122.35877641164;65621.34378656247;66993;67313.66343168252;8149.429539932148;8351.331893448389;9140.268778497837;9308.534573271445;9314.813703726024;32487.67512324941;40502;41990.79004604957;43203.35194972141;45324.546754532035;56619.71690141523;57607;62446.68776656088;62943.37056629375;63406;11935.224210426642;12009.760161875593;12118.151729378858;12149;12174;12457.314847683465;12693.42879570403;12842.165259258118;12980.286084265455;13047.543335983195;11164.944175279072;11205.159613028893;11252.549898004316;11293.491792869505;11499.597514086967;11841.407929603658;12082.318655435445;12187.146899716934;12296.200746951778;12410.069244806495;11317.094632429551;11734.70663233426;11947.462364193805;12011.393971932845;12055.276683399024;9669.371490853073;9914.900850991398;10054.798904022025;10056.64801731936;10192.337498062601;9075.636974520945;9153.93625239874;9755.951220243853;9857.852132218166;9929 06:11:42 INFO - PROCESS | 1897 | __end_tp_report 06:11:42 INFO - PROCESS | 1897 | __start_cc_report 06:11:42 INFO - PROCESS | 1897 | _x_x_mozilla_cycle_collect,321 06:11:42 INFO - PROCESS | 1897 | __end_cc_report 06:11:42 INFO - PROCESS | 1897 | __startTimestamp1478873502916__endTimestamp 06:11:42 INFO - PROCESS | 1897 | 06:11:42 INFO - PROCESS | 1897 | ------- Summary: start ------- 06:11:42 INFO - PROCESS | 1897 | Number of tests: 6 06:11:42 INFO - PROCESS | 1897 | 06:11:42 INFO - PROCESS | 1897 | [#0] dojo.html Cycles:165 Average:5376.62 Median:5631.10 stddev:639.56 (11.4%) stddev-sans-first:614.89 06:11:42 INFO - PROCESS | 1897 | Values: 3048.3 3051.0 3068.1 3079.3 3089.8 5302.4 5414.1 5440.4 5486.7 5531.5 5325.4 5396.8 5411.7 5476.6 5483.7 4812.6 4826.3 4924.9 4943.1 4986.7 4815.8 4880.0 4972.4 4980.1 5000.9 4764.3 4771.6 4797.7 4824.6 4855.8 4847.7 4858.7 4860.8 4871.6 4889.4 4661.1 4736.2 4825.0 4830.4 4844.3 5361.8 5400.2 5403.4 5408.9 5455.2 5810.1 5811.7 5812.7 5820.3 5822.8 5538.9 5650.2 5833.4 5864.3 5865.9 5344.9 5346.7 5352.3 5356.6 5375.3 5779.1 5784.1 5818.8 5869.7 5951.5 5647.8 5659.3 5669.8 5675.5 5681.1 5716.0 5719.1 5741.1 5752.7 5754.8 5676.7 5691.5 5704.1 5764.6 5777.0 5810.8 5819.3 5824.9 5825.0 5865.4 4363.3 4373.4 4389.9 4413.8 4420.9 3831.2 3859.7 3860.1 3902.5 3924.5 5553.1 5555.0 5620.6 5633.4 5644.1 5860.8 5862.5 5879.3 5900.4 5937.3 5415.8 5455.8 5462.5 5613.8 5615.4 4960.0 4964.4 5000.1 5033.7 5051.7 5920.9 5930.4 5967.2 5976.4 6012.2 5910.9 5946.2 5993.8 5997.0 6007.3 5802.1 5919.6 5923.8 6007.4 6011.5 5658.0 5667.5 5704.3 5771.8 5781.5 5837.1 5838.6 5844.9 5845.5 5911.3 5660.3 5711.0 5720.5 5725.9 5735.5 5578.6 5600.9 5631.1 5690.3 5726.9 5496.7 5573.5 5608.8 5652.8 5690.5 5763.9 5813.6 5818.7 5819.0 5854.2 5579.0 5604.5 5620.8 5650.8 5666.1 06:11:42 INFO - PROCESS | 1897 | 06:11:42 INFO - PROCESS | 1897 | [#1] ext.html Cycles:180 Average:56805.94 Median:40936.89 stddev:108292.44 (264.5%) stddev-sans-first:108513.89 06:11:42 INFO - PROCESS | 1897 | Values: 559.8 566.1 572.6 575.8 603.9 31749.8 40373.6 40818.0 41358.2 44692.0 43045.4 43496.6 43497.0 43541.8 43635.6 8439.5 8669.9 8683.6 8690.2 8699.4 8475.3 8529.2 8569.5 8571.7 8580.6 8472.2 8534.5 8548.2 8555.7 8570.0 8484.6 8496.5 8511.8 8556.3 8594.1 8458.6 8515.7 8545.0 8550.4 8557.4 40393.8 40702.0 40727.6 41055.8 41060.0 3504.0 3533.7 3659.5 3665.3 3665.7 30372.1 30832.2 31199.0 31347.5 31633.0 4114.3 4133.5 4194.3 4214.9 4296.0 306772.0 307344.0 308246.0 308623.0 309509.0 55074.7 55200.0 55241.0 55428.2 55718.4 59249.4 59556.4 59985.0 60253.4 60568.1 16824.8 17028.5 17070.3 17087.8 17168.0 12554.9 12572.6 12584.4 12606.7 12608.8 16982.6 17389.7 17404.6 17523.7 17530.0 6329.6 6357.3 6360.7 6655.6 6691.7 867.7 901.7 931.6 959.5 970.0 29268.6 31060.6 31080.8 31201.4 31386.7 1044.3 1048.2 1104.7 1116.3 1144.2 15504.4 16164.3 16377.3 16440.0 16480.8 457234.0 459812.0 462991.0 463533.0 463697.0 55987.0 56011.0 56368.7 56484.0 56597.7 1220.8 1265.6 1288.5 1301.9 1319.9 28782.6 32005.4 32338.5 33448.5 33806.3 54430.0 54501.7 55062.4 55122.4 55173.4 440040.0 440732.0 441993.0 443682.0 444439.0 38766.0 39608.0 40032.4 40351.0 40492.8 45971.5 45984.8 46452.3 47275.0 47686.5 38285.4 38371.6 38573.2 39818.6 40635.6 37902.2 38577.8 38587.8 40341.6 40479.2 34431.0 35512.3 37449.3 38689.4 39595.8 33258.8 35529.0 35759.5 35782.7 36020.5 26947.7 27576.7 27612.3 27657.0 27979.6 06:11:42 INFO - PROCESS | 1897 | 06:11:42 INFO - PROCESS | 1897 | [#2] jquery.html Cycles:180 Average:25328.97 Median:2528.71 stddev:61741.72 (2441.6%) stddev-sans-first:61886.53 06:11:42 INFO - PROCESS | 1897 | Values: 389.4 391.4 396.2 397.0 428.4 16402.1 16741.2 17630.3 19113.7 19126.5 11148.5 12418.8 12612.9 17568.3 19223.2 5015.9 5204.0 5217.3 5218.0 5234.0 4900.7 5189.2 5206.5 5215.2 5220.0 5176.9 5578.6 5875.6 5882.8 5966.3 5810.4 5840.0 5852.3 5891.4 5946.3 5689.8 5742.3 5758.7 5763.5 5771.8 13816.2 14185.1 22025.4 22843.5 23124.3 2287.3 2329.9 2426.8 2630.7 2642.6 9909.7 10021.2 10248.9 10400.3 10541.2 1829.5 1889.4 1894.4 1902.0 2011.1 73565.0 77544.6 80281.0 82022.6 82402.6 10206.2 10351.2 10492.6 11251.9 11385.6 15293.5 15367.5 15521.7 15559.3 15575.3 7546.4 7802.9 7822.0 7975.4 8025.2 7410.0 7526.2 7530.0 7681.5 7686.2 4626.5 4663.9 4753.4 4767.0 4778.0 1895.3 1979.2 1987.8 2055.1 2095.5 872.3 878.3 956.5 1004.2 1019.5 17509.3 17932.2 18379.9 18572.0 18873.2 948.3 973.5 994.8 1007.5 1029.6 10007.9 10348.6 10439.8 10555.2 10562.9 322459.0 325704.0 325981.0 424348.0 424961.0 88833.6 92711.5 95048.0 97117.0 97408.0 1009.4 1036.6 1072.2 1084.7 1090.5 16723.3 16970.8 17420.3 17630.6 17767.6 40648.0 42418.8 43714.3 44190.3 44262.0 60242.4 60865.7 61280.7 62558.0 64461.0 8399.6 8435.6 8465.3 8657.8 9086.5 9883.7 12948.3 13495.9 13605.5 13662.5 11191.5 11812.4 12068.9 12093.4 12145.9 11181.5 11339.1 11345.3 11468.7 11485.8 6393.9 8133.6 11557.0 11684.9 11875.1 8478.6 8683.8 11813.4 11822.0 12007.9 11649.8 12293.8 12313.1 12341.3 12966.7 06:11:42 INFO - PROCESS | 1897 | 06:11:42 INFO - PROCESS | 1897 | [#3] mootools.html Cycles:180 Average:5606.20 Median:5133.29 stddev:3145.80 (61.3%) stddev-sans-first:3139.15 06:11:42 INFO - PROCESS | 1897 | Values: 1454.4 1465.2 1605.2 1702.4 1715.2 7368.7 7603.3 8049.9 8561.5 8573.5 7924.8 8176.3 8181.3 8393.2 8407.5 2232.9 2264.5 2284.8 2285.5 2288.7 2244.1 2272.4 2318.1 2323.0 2337.6 2281.5 2290.7 2320.2 2361.8 2365.6 2234.2 2241.6 2259.0 2264.5 2276.4 2228.2 2249.0 2257.1 2258.6 2262.4 8438.8 8454.8 8516.4 8535.1 8605.9 5104.2 5208.3 5224.3 5249.1 5250.6 3176.0 3205.7 3548.7 3549.7 3561.1 1112.3 1117.7 1157.7 1174.0 1176.4 11706.9 11823.2 11923.8 11938.6 11955.9 4415.2 4619.8 4641.5 4719.9 4727.5 9935.6 9945.4 9960.6 9999.5 10013.7 5307.2 5318.1 5330.1 5352.7 5393.2 3984.6 4738.2 4806.0 4864.5 4918.1 3745.7 3799.2 3834.9 3887.7 3926.5 1274.1 1296.6 1300.2 1301.5 1320.0 947.9 957.5 981.5 983.7 993.7 5687.2 5786.6 5842.1 5892.3 6049.9 445.4 451.1 458.2 470.2 477.1 3941.4 3996.9 4004.5 4059.3 4092.9 10217.8 10407.5 10611.4 10619.3 10624.6 10480.6 10520.0 10529.0 10574.9 10592.2 7491.6 7868.5 7982.1 7982.3 7999.3 5618.9 5728.6 5729.4 5740.9 5743.9 9533.5 9563.7 9586.0 9706.7 9727.6 9183.6 9504.1 9508.6 9715.0 9744.3 6642.3 6795.4 7400.6 7481.6 7633.2 8010.3 8365.2 8383.2 8387.6 8400.4 7386.2 7465.1 7481.5 7607.1 7613.7 7183.7 7309.5 7310.4 7364.7 7387.7 6867.9 7001.1 7010.1 7025.2 7049.3 5094.5 5120.5 5179.6 5188.5 5420.3 4847.9 5074.5 5146.1 5204.5 5342.6 06:11:42 INFO - PROCESS | 1897 | 06:11:42 INFO - PROCESS | 1897 | [#4] prototype.html Cycles:180 Average:4755.86 Median:5370.68 stddev:1399.76 (26.1%) stddev-sans-first:1363.84 06:11:42 INFO - PROCESS | 1897 | Values: 337.6 341.2 348.1 351.9 353.3 5414.2 5467.0 5477.0 5492.6 5514.3 5365.5 5369.5 5371.8 5387.8 5393.2 3676.3 3989.5 4070.1 4105.6 4178.3 4151.6 4157.5 4159.4 4162.8 4166.5 4156.3 4158.7 4161.6 4164.8 4166.8 4036.3 4067.9 4146.9 4164.7 4168.8 3619.6 3620.5 3642.6 3651.5 3661.7 5211.2 5241.8 5267.2 5269.2 5276.7 4834.5 4845.7 4864.9 4874.8 4892.5 5378.3 5640.4 5662.2 5669.2 5677.5 4067.6 4073.2 4075.6 4084.0 4089.6 5648.0 5841.7 5852.2 5879.4 5880.3 4189.8 4254.5 4261.9 4269.2 4278.5 4311.2 4325.4 4351.6 4355.3 4357.9 4622.0 4853.9 4895.0 4906.7 4913.5 5624.9 5649.6 5657.2 5710.2 5723.6 1448.9 1451.8 1453.9 1454.4 1457.8 963.1 1006.9 1015.8 1026.1 1030.8 5219.5 5233.9 5244.8 5287.4 5289.8 5576.1 5577.6 5591.6 5591.8 5607.4 5006.8 5136.7 5241.5 5259.5 5272.8 2973.8 2983.2 2993.8 2994.2 2995.1 5653.5 5691.6 5720.5 5738.2 5778.0 5689.9 5983.9 5991.6 6018.4 6047.0 5970.5 5989.7 6007.3 6073.4 6075.5 5706.3 5867.4 5880.2 5924.8 5932.3 5739.5 5802.7 5816.2 5824.2 5842.3 5818.9 5963.8 6011.7 6050.5 6050.7 4104.9 4123.6 4124.1 4133.4 4141.9 5745.3 5867.7 5880.7 5891.6 5907.4 5666.0 5687.7 5696.2 5719.9 5741.3 5700.6 5725.7 5729.7 5741.5 5743.0 5501.6 5624.6 5652.9 5656.0 5662.9 5713.7 5719.3 5736.9 5751.6 5756.5 5615.3 5627.5 5634.0 5635.4 5646.2 06:11:42 INFO - PROCESS | 1897 | 06:11:42 INFO - PROCESS | 1897 | [#5] yui.html Cycles:180 Average:16400.78 Median:57634.21 stddev:21818.09 (37.9%) stddev-sans-first:21847.52 06:11:42 INFO - PROCESS | 1897 | Values: 720.0 728.3 739.8 752.2 768.8 13674.7 14434.1 14583.5 14787.2 14978.4 12799.1 13461.8 13599.7 13616.7 13624.0 659.3 775.1 785.9 789.9 790.3 785.1 785.3 786.9 787.5 788.8 805.3 806.3 806.7 809.0 810.9 807.7 807.9 807.9 809.6 810.2 589.3 593.6 593.7 594.1 595.5 12305.3 12672.0 12677.0 12787.9 12800.8 11334.7 11690.4 11765.5 11843.5 12084.7 9689.3 9833.2 9943.2 10279.7 10285.9 3460.8 3507.1 3529.6 3547.5 3558.2 51994.7 53070.5 53661.0 59993.0 60486.7 10124.2 10249.2 10265.5 10291.6 10538.3 18935.2 18943.6 18994.8 19129.7 19151.4 7833.8 7950.6 8060.9 8085.2 8197.1 4352.6 4396.5 4436.0 4461.3 4502.3 3445.5 3485.1 3536.8 3556.4 3571.5 596.0 616.9 617.1 628.2 645.8 691.5 702.4 708.2 708.5 729.1 8296.5 8601.2 8712.7 8731.1 8756.7 616.4 616.5 640.7 678.6 680.1 4217.4 4374.8 4452.6 4456.8 4492.2 54763.7 57661.4 88669.6 91553.5 94349.0 58553.7 60166.7 69795.0 83128.0 84139.0 63833.7 64122.4 65621.3 66993.0 67313.7 8149.4 8351.3 9140.3 9308.5 9314.8 32487.7 40502.0 41990.8 43203.4 45324.5 56619.7 57607.0 62446.7 62943.4 63406.0 11935.2 12009.8 12118.2 12149.0 12174.0 12457.3 12693.4 12842.2 12980.3 13047.5 11164.9 11205.2 11252.5 11293.5 11499.6 11841.4 12082.3 12187.1 12296.2 12410.1 11317.1 11734.7 11947.5 12011.4 12055.3 9669.4 9914.9 10054.8 10056.6 10192.3 9075.6 9153.9 9756.0 9857.9 9929.0 06:11:42 INFO - PROCESS | 1897 | -------- Summary: end -------- 06:11:42 INFO - PROCESS | 1897 | 06:11:43 INFO - TEST-INFO | 1897: exit 0 06:11:43 INFO - TEST-OK | dromaeo_css | took 1115408ms 06:11:43 INFO - TEST-START | kraken 06:11:43 INFO - operating with platform_type : linux_ 06:11:43 INFO - Initialising browser for kraken test... 06:11:43 INFO - TEST-INFO | started process 2256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx_uJ9E/profile http://localhost:32873/getInfo.html) 06:11:47 INFO - PROCESS | 2256 | __metrics Screen width/height:1600/1200 06:11:47 INFO - PROCESS | 2256 | colorDepth:24 06:11:47 INFO - PROCESS | 2256 | Browser inner width/height: 1024/697 06:11:47 INFO - PROCESS | 2256 | __metrics 06:11:48 ERROR - PROCESS | 2256 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 06:11:49 INFO - TEST-INFO | 2256: exit 0 06:11:49 INFO - Browser initialized. 06:11:49 INFO - Running cycle 1/1 for kraken test... 06:11:49 INFO - TEST-INFO | started process 2379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx_uJ9E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:01 INFO - PROCESS | 2379 | RSS: Main: 185516032 06:12:01 INFO - PROCESS | 2379 | 06:12:04 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:32873/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32873/tests/kraken/driver.html?testName=audio-beat-detection) 06:12:05 INFO - PROCESS | 2379 | RSS: Main: 193785856 06:12:05 INFO - PROCESS | 2379 | 06:12:07 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:32873/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32873/tests/kraken/driver.html?testName=audio-dft) 06:12:08 INFO - PROCESS | 2379 | RSS: Main: 196657152 06:12:08 INFO - PROCESS | 2379 | 06:12:11 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:32873/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32873/tests/kraken/driver.html?testName=audio-fft) 06:12:11 INFO - PROCESS | 2379 | RSS: Main: 192983040 06:12:11 INFO - PROCESS | 2379 | 06:12:13 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:32873/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32873/tests/kraken/driver.html?testName=audio-oscillator) 06:12:14 INFO - PROCESS | 2379 | RSS: Main: 193228800 06:12:14 INFO - PROCESS | 2379 | 06:12:16 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:32873/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32873/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:12:17 INFO - PROCESS | 2379 | RSS: Main: 193896448 06:12:17 INFO - PROCESS | 2379 | 06:12:20 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:32873/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32873/tests/kraken/driver.html?testName=imaging-darkroom) 06:12:20 INFO - PROCESS | 2379 | RSS: Main: 194162688 06:12:20 INFO - PROCESS | 2379 | 06:12:24 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:32873/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32873/tests/kraken/driver.html?testName=imaging-desaturate) 06:12:25 INFO - PROCESS | 2379 | RSS: Main: 192499712 06:12:25 INFO - PROCESS | 2379 | 06:12:27 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:32873/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32873/tests/kraken/driver.html?testName=json-parse-financial) 06:12:28 INFO - PROCESS | 2379 | RSS: Main: 193208320 06:12:28 INFO - PROCESS | 2379 | 06:12:29 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:32873/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32873/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:12:30 INFO - PROCESS | 2379 | RSS: Main: 193417216 06:12:30 INFO - PROCESS | 2379 | 06:12:32 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:32873/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32873/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:12:32 INFO - PROCESS | 2379 | RSS: Main: 193703936 06:12:32 INFO - PROCESS | 2379 | 06:12:35 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:32873/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32873/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:12:35 INFO - PROCESS | 2379 | RSS: Main: 193748992 06:12:35 INFO - PROCESS | 2379 | 06:12:38 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:32873/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32873/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:12:39 INFO - PROCESS | 2379 | RSS: Main: 193613824 06:12:39 INFO - PROCESS | 2379 | 06:12:42 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:32873/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32873/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:12:42 INFO - PROCESS | 2379 | RSS: Main: 194392064 06:12:42 INFO - PROCESS | 2379 | 06:12:44 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:32873/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32873/tests/kraken/driver.html?testName=ai-astar) 06:12:44 INFO - PROCESS | 2379 | RSS: Main: 195088384 06:12:44 INFO - PROCESS | 2379 | 06:12:44 INFO - PROCESS | 2379 | __start_tp_report 06:12:44 INFO - PROCESS | 2379 | _x_x_mozilla_page_load 06:12:44 INFO - PROCESS | 2379 | _x_x_mozilla_page_load_details 06:12:44 INFO - PROCESS | 2379 | |i|pagename|runs| 06:12:44 INFO - PROCESS | 2379 | |0;ai-astar;107;113;114;114;115;113;114;115;113;116 06:12:44 INFO - PROCESS | 2379 | |1;audio-beat-detection;161;125;126;173;126;124;127;126;167;126 06:12:44 INFO - PROCESS | 2379 | |2;audio-dft;163;163;166;175;163;161;163;164;163;162 06:12:44 INFO - PROCESS | 2379 | |3;audio-fft;75;76;76;107;77;76;77;77;104;76 06:12:44 INFO - PROCESS | 2379 | |4;audio-oscillator;83;83;110;84;84;83;104;83;84;109 06:12:44 INFO - PROCESS | 2379 | |5;imaging-gaussian-blur;119;119;119;118;117;118;118;117;117;118 06:12:44 INFO - PROCESS | 2379 | |6;imaging-darkroom;148;147;148;148;148;149;148;148;149;148 06:12:44 INFO - PROCESS | 2379 | |7;imaging-desaturate;85;87;86;86;85;85;86;85;85;85 06:12:44 INFO - PROCESS | 2379 | |8;json-parse-financial;52;53;54;52;51;53;53;55;55;59 06:12:44 INFO - PROCESS | 2379 | |9;json-stringify-tinderbox;63;64;62;64;65;64;63;63;63;63 06:12:44 INFO - PROCESS | 2379 | |10;stanford-crypto-aes;82;81;82;80;80;81;82;82;81;89 06:12:44 INFO - PROCESS | 2379 | |11;stanford-crypto-ccm;136;138;134;138;146;148;141;131;187;137 06:12:44 INFO - PROCESS | 2379 | |12;stanford-crypto-pbkdf2;171;170;168;167;177;173;164;164;169;166 06:12:44 INFO - PROCESS | 2379 | |13;stanford-crypto-sha256-iterative;65;69;65;64;66;65;64;64;66;63 06:12:44 INFO - PROCESS | 2379 | __end_tp_report 06:12:44 INFO - PROCESS | 2379 | __start_cc_report 06:12:44 INFO - PROCESS | 2379 | _x_x_mozilla_cycle_collect,797 06:12:44 INFO - PROCESS | 2379 | __end_cc_report 06:12:44 INFO - PROCESS | 2379 | __startTimestamp1478873564645__endTimestamp 06:12:44 INFO - PROCESS | 2379 | 06:12:44 INFO - PROCESS | 2379 | ------- Summary: start ------- 06:12:44 INFO - PROCESS | 2379 | Number of tests: 14 06:12:44 INFO - PROCESS | 2379 | 06:12:44 INFO - PROCESS | 2379 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:2.46 (2.2%) stddev-sans-first:1.05 06:12:44 INFO - PROCESS | 2379 | Values: 107.0 113.0 114.0 114.0 115.0 113.0 114.0 115.0 113.0 116.0 06:12:44 INFO - PROCESS | 2379 | 06:12:44 INFO - PROCESS | 2379 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:126.50 stddev:20.16 (15.9%) stddev-sans-first:19.60 06:12:44 INFO - PROCESS | 2379 | Values: 161.0 125.0 126.0 173.0 126.0 124.0 127.0 126.0 167.0 126.0 06:12:44 INFO - PROCESS | 2379 | 06:12:44 INFO - PROCESS | 2379 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.00 stddev:3.97 (2.4%) stddev-sans-first:4.19 06:12:44 INFO - PROCESS | 2379 | Values: 163.0 163.0 166.0 175.0 163.0 161.0 163.0 164.0 163.0 162.0 06:12:44 INFO - PROCESS | 2379 | 06:12:44 INFO - PROCESS | 2379 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:12.37 (16.3%) stddev-sans-first:12.85 06:12:44 INFO - PROCESS | 2379 | Values: 75.0 76.0 76.0 107.0 77.0 76.0 77.0 77.0 104.0 76.0 06:12:44 INFO - PROCESS | 2379 | 06:12:44 INFO - PROCESS | 2379 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:83.00 stddev:11.81 (14.2%) stddev-sans-first:12.20 06:12:44 INFO - PROCESS | 2379 | Values: 83.0 83.0 110.0 84.0 84.0 83.0 104.0 83.0 84.0 109.0 06:12:44 INFO - PROCESS | 2379 | 06:12:44 INFO - PROCESS | 2379 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 06:12:44 INFO - PROCESS | 2379 | Values: 119.0 119.0 119.0 118.0 117.0 118.0 118.0 117.0 117.0 118.0 06:12:44 INFO - PROCESS | 2379 | 06:12:44 INFO - PROCESS | 2379 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 06:12:44 INFO - PROCESS | 2379 | Values: 148.0 147.0 148.0 148.0 148.0 149.0 148.0 148.0 149.0 148.0 06:12:44 INFO - PROCESS | 2379 | 06:12:44 INFO - PROCESS | 2379 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 06:12:44 INFO - PROCESS | 2379 | Values: 85.0 87.0 86.0 86.0 85.0 85.0 86.0 85.0 85.0 85.0 06:12:44 INFO - PROCESS | 2379 | 06:12:44 INFO - PROCESS | 2379 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.50 stddev:2.26 (4.2%) stddev-sans-first:2.32 06:12:44 INFO - PROCESS | 2379 | Values: 52.0 53.0 54.0 52.0 51.0 53.0 53.0 55.0 55.0 59.0 06:12:44 INFO - PROCESS | 2379 | 06:12:44 INFO - PROCESS | 2379 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 06:12:44 INFO - PROCESS | 2379 | Values: 63.0 64.0 62.0 64.0 65.0 64.0 63.0 63.0 63.0 63.0 06:12:44 INFO - PROCESS | 2379 | 06:12:44 INFO - PROCESS | 2379 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:2.58 (3.1%) stddev-sans-first:2.74 06:12:44 INFO - PROCESS | 2379 | Values: 82.0 81.0 82.0 80.0 80.0 81.0 82.0 82.0 81.0 89.0 06:12:44 INFO - PROCESS | 2379 | 06:12:44 INFO - PROCESS | 2379 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:139.50 stddev:16.09 (11.5%) stddev-sans-first:16.83 06:12:44 INFO - PROCESS | 2379 | Values: 136.0 138.0 134.0 138.0 146.0 148.0 141.0 131.0 187.0 137.0 06:12:44 INFO - PROCESS | 2379 | 06:12:44 INFO - PROCESS | 2379 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:169.50 stddev:4.07 (2.4%) stddev-sans-first:4.24 06:12:44 INFO - PROCESS | 2379 | Values: 171.0 170.0 168.0 167.0 177.0 173.0 164.0 164.0 169.0 166.0 06:12:44 INFO - PROCESS | 2379 | 06:12:44 INFO - PROCESS | 2379 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:1.66 (2.6%) stddev-sans-first:1.76 06:12:44 INFO - PROCESS | 2379 | Values: 65.0 69.0 65.0 64.0 66.0 65.0 64.0 64.0 66.0 63.0 06:12:44 INFO - PROCESS | 2379 | -------- Summary: end -------- 06:12:44 INFO - PROCESS | 2379 | 06:12:45 INFO - TEST-INFO | 2379: exit 0 06:12:45 INFO - TEST-OK | kraken | took 61903ms 06:12:45 INFO - SUITE-END | took 1177s 06:12:46 INFO - Completed test suite (00:19:37) 06:12:46 INFO - javascript benchmark 06:12:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7022.831355050569, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3048.253177971397, 3050.9847450762772, 3068.079576127161, 3079.3379423423958, 3089.799163054401, 5302.363716354033, 5414.106672399054, 5440.3743569489525, 5486.698231597261, 5531.474509921561, 5325.387580428252, 5396.811111611094, 5411.675299482034, 5476.58925580582, 5483.725813709319, 4812.639052071091, 4826.276058591205, 4924.901501969976, 4943.1102401567705, 4986.650934434591, 4815.783289751952, 4879.9512004880025, 4972.428170760372, 4980.078685443204, 5000.924986125211, 4764.285357196413, 4771.570558649738, 4797.71213727174, 4824.638152138604, 4855.805767769302, 4847.684900481458, 4858.732769697665, 4860.781264843091, 4871.561559459666, 4889.437714662824, 4661.09108723799, 4736.242201247784, 4824.951750482521, 4830.420349558076, 4844.346013288196, 5361.839144825662, 5400.162974738922, 5403.405625381205, 5408.864778380533, 5455.18172274158, 5810.070388737781, 5811.651300921958, 5812.651240925558, 5820.301563812327, 5822.82531524055, 5538.944610553924, 5650.152477128422, 5833.358330583633, 5864.296284445851, 5865.882682346371, 5344.893102137974, 5346.732663366816, 5352.277442545284, 5356.625036247464, 5375.3012108425655, 5779.075347944393, 5784.074548072288, 5818.8254352369495, 5869.735861886225, 5951.5238780897425, 5647.774089036475, 5659.349174844863, 5669.829905102771, 5675.489205971482, 5681.0910254359105, 5716.028275193227, 5719.056355701263, 5741.110127930177, 5752.654840709571, 5754.769809207585, 5676.716164191774, 5691.516221121168, 5704.11586204139, 5764.567657425626, 5777.0467872801355, 5810.7966221182905, 5819.330776960619, 5824.854378640568, 5825.0388685866355, 5865.384134665884, 4363.301871700576, 4373.387725718402, 4389.934150987738, 4413.7572433515825, 4420.8673739787855, 3831.1954489556947, 3859.6526312631436, 3860.1121741999495, 3902.473166122537, 3924.489816323917, 5553.111502159635, 5555.0, 5620.57845661577, 5633.408492108351, 5644.125160600113, 5860.794872179454, 5862.472377486047, 5879.2944846618675, 5900.43945825146, 5937.287525496881, 5415.756290966916, 5455.781768729285, 5462.5083742462575, 5613.803516876889, 5615.410381909841, 4959.975200123977, 4964.429090654621, 5000.1249781288125, 5033.672811267256, 5051.747412629354, 5920.8815823684145, 5930.377310382348, 5967.16459695643, 5976.372480889618, 6012.248468941382, 5910.881782364243, 5946.167536544801, 5993.820185394445, 5997.010493268736, 6007.309159446545, 5802.100674395476, 5919.6152250103605, 5923.7926672566255, 6007.429294217042, 6011.549133815069, 5657.981563318642, 5667.4615911488345, 5704.286964129484, 5771.769129234784, 5781.479666830005, 5837.066069429041, 5838.591298609056, 5844.853878653068, 5845.532357411312, 5911.3201981772645, 5660.29246344207, 5710.971445142914, 5720.45655662728, 5725.914111288417, 5735.54115670737, 5578.581606379456, 5600.8879822402505, 5631.099024156116, 5690.317161940594, 5726.914096288476, 5496.697681627549, 5573.470520300565, 5608.803691870765, 5652.830415087554, 5690.487856092972, 5763.884722305615, 5813.593048486735, 5818.650880947157, 5818.970905145447, 5854.180414742024, 5579.0, 5604.523615492729, 5620.8032718856275, 5650.830475085754, 5666.093425051972], "value": 5331.12208417955, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.815260963882, 566.0829456280825, 572.5734327925696, 575.8301301116171, 603.8912995660783, 31749.841250793743, 40373.59626403735, 40817.97955051121, 41358.17283654325, 44692.0, 43045.35431968515, 43496.565034349645, 43497.0, 43541.7822910885, 43635.563644363545, 8439.451435656694, 8669.913300866974, 8683.609237584293, 8690.174433428845, 8699.39104262702, 8475.279601233902, 8529.232369086782, 8569.485830850137, 8571.657133714643, 8580.570971451434, 8472.19514146155, 8534.530600816952, 8548.230659240668, 8555.743327700147, 8570.0, 8484.575771211477, 8496.490210587353, 8511.829763404729, 8556.315494760403, 8594.054653988056, 8458.577071146417, 8515.74452766418, 8544.957275213646, 8550.40147189697, 8557.400981931267, 40393.798031009654, 40702.0, 40727.592724072674, 41055.79472102621, 41060.0, 3503.9824800876086, 3533.6643018913164, 3659.469376940329, 3665.303592317478, 3665.688416484602, 30372.088837334693, 30832.229194270098, 31199.0, 31347.529787053212, 31633.0, 4114.326780554275, 4133.483314585676, 4194.30793919003, 4214.894627634334, 4296.0, 306772.0, 307344.0, 308246.0, 308623.0, 309509.0, 55074.724626376614, 55200.0, 55241.0, 55428.1915026574, 55718.44281557214, 59249.40750592439, 59556.404435955956, 59985.0, 60253.39746602566, 60568.09147862786, 16824.831751682326, 17028.48914532566, 17070.317187312616, 17087.829121708623, 17168.0, 12554.928436807824, 12572.622821315375, 12584.37078146089, 12606.684832879067, 12608.81086783699, 16982.575435613962, 17389.739153912447, 17404.564885877953, 17523.73714394285, 17530.0, 6329.556931014785, 6357.268914074941, 6360.681965901686, 6655.6339401332425, 6691.7323307068145, 867.6616119713317, 901.7024381953939, 931.6040682709821, 959.5298303831072, 969.9515024248759, 29268.560971585444, 31060.598540870604, 31080.84459577733, 31201.375972480422, 31386.68613313883, 1044.300318786415, 1048.1771809129796, 1104.6851647280487, 1116.268843907242, 1144.1533265383723, 15504.379824807107, 16164.27260773268, 16377.344906203856, 16440.019306075854, 16480.83519164793, 457234.0, 459812.0, 462991.0, 463533.0, 463697.0, 55987.0, 56011.0, 56368.718156408955, 56484.0, 56597.71701141468, 1220.7863623865965, 1265.6329664397406, 1288.5103660608909, 1301.8828305452555, 1319.940602672882, 28782.568261475677, 32005.35989280248, 32338.514922276656, 33448.498272525445, 33806.32387352288, 54430.0, 54501.72749136229, 55062.449375507334, 55122.417042892084, 55173.44826551683, 440040.0, 440732.0, 441993.0, 443682.0, 444439.0, 38766.0, 39608.0, 40032.39951400673, 40351.0, 40492.797536012135, 45971.540284596726, 45984.770076149405, 46452.30321545112, 47275.0, 47686.523134769595, 38285.4257186148, 38371.616283837924, 38573.2285354297, 39818.60181398149, 40635.59364406318, 37902.24195516019, 38577.80711096426, 38587.807060964515, 40341.59658403378, 40479.1904161921, 34431.0, 35512.289754204256, 37449.251014980095, 38689.41965870458, 39595.80202098971, 33258.83370583229, 35529.0, 35759.46360804642, 35782.74760383374, 36020.4596931041, 26947.73052269452, 27576.724232757417, 27612.30969225705, 27657.0, 27979.58030629583], "value": 19526.455488938973, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.38671592242207, 391.37380191693313, 396.1502576972395, 396.9622885825846, 428.4473029791569, 16402.09788461634, 16741.16294185292, 17630.294788208474, 19113.713294300596, 19126.52183695408, 11148.498317575708, 12418.751624967495, 12612.936935315334, 17568.29726810926, 19223.231070757152, 5015.874603134915, 5204.0, 5217.34783152106, 5217.973910130463, 5234.031704134728, 4900.681455705386, 5189.195674670414, 5206.45332240115, 5215.217717342391, 5219.973900130494, 5176.922346164811, 5578.553715702755, 5875.559333050017, 5882.823515294526, 5966.343702192756, 5810.448007439287, 5840.0, 5852.268466441695, 5891.410858914117, 5946.286445626552, 5689.772409103631, 5742.339630942453, 5758.654480731169, 5763.452472015152, 5771.826845194651, 13816.240106794123, 14185.148891066568, 22025.449363765874, 22843.54312913749, 23124.306270811903, 2287.3481057898584, 2329.860208387502, 2426.7694569015916, 2630.658014458127, 2642.616820561027, 9909.662195603645, 10021.248406369552, 10248.897511024868, 10400.271980961335, 10541.156707463384, 1829.5426143464133, 1889.3670620342202, 1894.4411398637435, 1901.995503650793, 2011.1251605551631, 73565.0, 77544.61227693825, 80281.0, 82022.58988705078, 82402.58798706028, 10206.183505319557, 10351.171906247482, 10492.632757853438, 11251.887481125084, 11385.601503947322, 15293.541193764206, 15367.538973830802, 15521.689566208612, 15559.29983150761, 15575.299111540007, 7546.434017448713, 7802.921970780333, 7822.0, 7975.4018448615425, 8025.2376024278765, 7410.0, 7526.172121066678, 7530.0, 7681.500702454323, 7686.192949740309, 4626.496388673694, 4663.930041049387, 4753.405824271966, 4766.95233047672, 4777.95222047775, 1895.2563641449624, 1979.2281010405952, 1987.7614686237744, 2055.095757866534, 2095.549456866781, 872.2629378175432, 878.3368556739748, 956.5360800011989, 1004.2116938203475, 1019.5106348952544, 17509.299628014738, 17932.193051312723, 18379.90810045968, 18572.0, 18873.207045330946, 948.3314263444255, 973.4694591447678, 994.7662299359645, 1007.5314978534869, 1029.6087486755134, 10007.949960250153, 10348.637797677045, 10439.791204175874, 10555.208359373079, 10562.894371056345, 322459.0, 325704.0, 325981.0, 424348.0, 424961.0, 88833.55583222043, 92711.53644231871, 95048.0, 97117.0, 97408.0, 1009.3590569987964, 1036.5594622285498, 1072.2172813845937, 1084.734240111162, 1090.4547726136932, 16723.33106675768, 16970.830291697417, 17420.30318787234, 17630.559236019202, 17767.55581110431, 40648.0, 42418.78790606027, 43714.34428483512, 44190.33714494221, 44262.0, 60242.39757602368, 60865.69567152136, 61280.69359653173, 62558.0, 64461.0, 8399.622017009127, 8435.613480989974, 8465.322774178174, 8657.783555411164, 9086.500242486727, 9883.654072107442, 12948.28784416866, 13495.932520337336, 13605.455781768618, 13662.521811736542, 11191.496382662637, 11812.3503207321, 12068.939655301667, 12093.395330233629, 12145.878541214828, 11181.496832642388, 11339.149563782585, 11345.319280843176, 11468.713282168013, 11485.770284594095, 6393.8721225576155, 8133.633986470742, 11557.0, 11684.88315116872, 11875.109366797698, 8478.618462169094, 8683.82632347337, 11813.409329533317, 11822.0, 12007.879921201025, 11649.767004660029, 12293.815592765937, 12313.13808033429, 12341.259524428562, 12966.675833104247], "value": 8977.866651940527, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1454.3528129982155, 1465.2307538542264, 1605.2214675882194, 1702.429686055173, 1715.1595718098129, 7368.668409921553, 7603.277688619586, 8049.8792518112205, 8561.486310821356, 8573.485590864537, 7924.762257132281, 8176.264136227738, 8181.263686268235, 8393.24460798528, 8407.453515521487, 2232.910683572655, 2264.501809601885, 2284.805791507724, 2285.5086156476355, 2288.6567014947723, 2244.068711484732, 2272.409173614864, 2318.13070098713, 2322.9767702323015, 2337.5792357375667, 2281.5094754627753, 2290.656401539774, 2320.2459200759736, 2361.8464799787957, 2365.6096744037213, 2234.229190929135, 2241.5628952354296, 2259.0399080390935, 2264.4565304326925, 2276.4081338852016, 2228.186711850163, 2249.044156233594, 2257.142285931352, 2258.6160352740076, 2262.4230821140504, 8438.831223375499, 8454.830903381899, 8516.403851730382, 8535.140727856176, 8605.870911936327, 5104.183330667075, 5208.348956380452, 5224.320838290998, 5249.081410753141, 5250.606204534637, 3175.984120079408, 3205.727513161384, 3548.7338449616122, 3549.716022718176, 3561.145325121978, 1112.3437172068518, 1117.664700589828, 1157.6816375496721, 1173.9941300293528, 1176.4353110507004, 11706.882931170665, 11823.231489953125, 11923.761524769456, 11938.582149624808, 11955.880441195564, 4415.205263052681, 4619.838305659286, 4641.535846415331, 4719.882002949954, 4727.456342520654, 9935.602575896883, 9945.403275803475, 9960.601575936882, 9999.50002499872, 10013.749656258506, 5307.203919412119, 5318.122509785842, 5330.120530112566, 5352.678839269656, 5393.2449457076045, 3984.601539845992, 4738.241881298975, 4805.975970120127, 4864.489228630943, 4918.139325618003, 3745.7003439725304, 3799.2021675447913, 3834.9041273968373, 3887.669548088444, 3926.509186351706, 1274.1272228523492, 1296.572131196703, 1300.1938797945334, 1301.4989229146847, 1319.9802002969964, 947.8672985781996, 957.4781743949565, 981.5337714585658, 983.6753871222479, 993.6820217530321, 5687.175359572839, 5786.623869448473, 5842.094475356242, 5892.322382925932, 6049.879002420015, 445.4298497922664, 451.14282862561396, 458.15013150605813, 470.2335193634354, 477.067333363274, 3941.3890846918775, 3996.9400458993136, 4004.4994375703036, 4059.330210515291, 4092.9181416371507, 10217.795644087077, 10407.531661075118, 10611.363318200933, 10619.256652034283, 10624.575016999388, 10480.580776768997, 10520.0, 10529.0, 10574.89425105739, 10592.205584581186, 7491.625418729151, 7868.488548244346, 7982.121966583672, 7982.321502672338, 7999.3200577950365, 5618.85952851182, 5728.627639203439, 5729.3984131665575, 5740.942590574041, 5743.856403589776, 9533.47565883883, 9563.665271715456, 9585.952070239604, 9706.660266890907, 9727.610895564381, 9183.632654693738, 9504.144626983605, 9508.619655213713, 9715.0, 9744.269179811401, 6642.335766423319, 6795.38841504267, 7400.629968501446, 7481.551106933602, 7633.1985141559335, 8010.279074883289, 8365.24712775853, 8383.245507904074, 8387.580620968805, 8400.369972252227, 7386.224446433047, 7465.141508726349, 7481.476296659399, 7607.087149542091, 7613.733519326797, 7183.676734546853, 7309.451791115794, 7310.415166786751, 7364.668589913574, 7387.667554959932, 6867.931320686929, 7001.124859392576, 7010.123734533184, 7025.192102908231, 7049.330313620198, 5094.465081166424, 5120.513551212629, 5179.559737422362, 5188.507091826271, 5420.295361602966, 4847.927281090716, 5074.492550745043, 5146.073706732824, 5204.5315921565725, 5342.599305052215], "value": 4452.610665413267, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.5679130712687, 341.17605981554544, 348.14530328044646, 351.89443167049876, 353.2934131736527, 5414.186247607052, 5467.031868527327, 5476.972615136919, 5492.615516913813, 5514.310711161105, 5365.543928766059, 5369.543588794957, 5371.81198658047, 5387.757550910209, 5393.2449457076045, 3676.3015027144756, 3989.521257449103, 4070.1277412390336, 4105.624615753711, 4178.289690752579, 4151.647109995654, 4157.48031496063, 4159.3968874513175, 4162.771047592381, 4166.479190101238, 4156.314208155651, 4158.667306615479, 4161.563035881234, 4164.750114993095, 4166.791660416982, 4036.2734707752593, 4067.9186416271805, 4146.896327591804, 4164.68764842638, 4168.791560421982, 3619.5837478690023, 3620.529331186955, 3642.6175251598465, 3651.5070465487083, 3661.6521430464063, 5211.24436956643, 5241.8165364212455, 5267.183586544092, 5269.235960785703, 5276.709780962045, 4834.492378300263, 4845.660803743739, 4864.902701945941, 4874.7562621868765, 4892.486288939681, 5378.327709036371, 5640.351359593658, 5662.207290979266, 5669.177969194444, 5677.460641239076, 4067.633912947849, 4073.226087043482, 4075.6331930126134, 4083.9591604083876, 4089.591040895916, 5647.989927151727, 5841.678707671076, 5852.239208902815, 5879.441453061952, 5880.294364676223, 4189.7695626740215, 4254.489461264668, 4261.850835220753, 4269.23153832307, 4278.486581610165, 4311.159323931804, 4325.437693099877, 4351.564843515623, 4355.2813785725, 4357.8669545917655, 4621.976890115528, 4853.878653033702, 4894.975525122351, 4906.705597664151, 4913.459519452857, 5624.91562626561, 5649.604527683023, 5657.161422537692, 5710.229119068873, 5723.5691077230695, 1448.9205541871163, 1451.75320195567, 1453.8764205042478, 1454.3818876977243, 1457.7594696874896, 963.1235575626147, 1006.9295149339622, 1015.7816069545083, 1026.14829691356, 1030.7526193713454, 5219.478052194826, 5233.921491177635, 5244.770972336742, 5287.365516138088, 5289.841304760864, 5576.1356989666665, 5577.637453565505, 5591.6365436246515, 5591.804286849941, 5607.383187849333, 5006.774695138727, 5136.666116702402, 5241.475852414805, 5259.474052594786, 5272.815451459181, 2973.7769667274606, 2983.224361665939, 2993.760499160062, 2994.1616347422755, 2995.1164406499697, 5653.519450846642, 5691.573132015115, 5720.48515633595, 5738.225339579187, 5778.006587727227, 5689.9146512802345, 5983.940160598426, 5991.610545314541, 6018.428249316308, 6047.0, 5970.462658360769, 5989.730462129215, 6007.27912650476, 6073.360192748021, 6075.483583895419, 5706.28671416073, 5867.354590995073, 5880.235569375954, 5924.763009479572, 5932.317783454958, 5739.483446489836, 5802.738876750641, 5816.1857339973285, 5824.21373114641, 5842.269716285465, 5818.865321262313, 5963.821085367446, 6011.6693581853415, 6050.485708714633, 6050.727717252822, 4104.897377565465, 4123.628873401408, 4124.13393187422, 4133.400656904792, 4141.8964525887095, 5745.253117094918, 5867.6772777497645, 5880.735366908585, 5891.587588868738, 5907.438793314628, 5665.971670141623, 5687.687177205128, 5696.174054762119, 5719.885602287848, 5741.311042674905, 5700.600957932905, 5725.652482482163, 5729.656220626775, 5741.5406767459335, 5743.0, 5501.642393244426, 5624.606277560531, 5652.943470565242, 5656.038473459439, 5662.886742265214, 5713.714314284186, 5719.256496655408, 5736.913946290892, 5751.626144300607, 5756.481916627524, 5615.298087739033, 5627.493525582717, 5633.971830140823, 5635.408282130317, 5646.221440246473], "value": 4315.668014716191, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.9964000179998, 728.275366010819, 739.79285799976, 752.1801236652049, 768.8462307538492, 13674.658133546654, 14434.13395196289, 14583.489577864777, 14787.186704731235, 14978.400863965428, 12799.104062715614, 13461.798073028887, 13599.660008499792, 13616.659583510418, 13624.0, 659.3406593406605, 775.0621747685279, 785.9135495095535, 789.9328557072656, 790.328221012138, 785.1089013969129, 785.3403141361256, 786.9016372953381, 787.5432249295395, 788.787027502574, 805.3355981315439, 806.3065763443434, 806.6894245715383, 809.017044291186, 810.8743144812563, 807.6567458830003, 807.858624740668, 807.907090684573, 809.5749731391008, 810.2059981218409, 589.2751915144396, 593.6438137117738, 593.7239183779564, 594.0999385930319, 595.511680422054, 12305.26168429897, 12672.049596280223, 12676.95979712098, 12787.936060319731, 12800.80798788019, 11334.659960201207, 11690.357030363326, 11765.529378824922, 11843.46704398304, 12084.697882552919, 9689.32174747768, 9833.21334293262, 9943.154831839302, 10279.743006424824, 10285.9485702571, 3460.8269586520823, 3507.1232191952013, 3529.6470352964757, 3547.52108465359, 3558.2349794794245, 51994.7400263, 53070.46929530694, 53661.0, 59993.001049842875, 60486.697566512325, 10124.190064794946, 10249.180065594735, 10265.538050787733, 10291.639792607222, 10538.315009524356, 18935.242590296235, 18943.62112757737, 18994.810051899305, 19129.713054304197, 19151.425457236306, 7833.764987050397, 7950.602469876483, 8060.919390806017, 8085.191480851868, 8197.098319184885, 4352.564743525622, 4396.538363471789, 4436.0462500562535, 4461.330800379904, 4502.279635258408, 3445.4831775233915, 3485.076454739496, 3536.8231588420476, 3556.3776339140545, 3571.5357003589365, 595.9940400595939, 616.9352218017133, 617.0559044661675, 628.2398298059308, 645.8449972006779, 691.5021184746975, 702.4064665357764, 708.1820497325597, 708.4757279613152, 729.1032030602389, 8296.502209867427, 8601.179249965273, 8712.651493940171, 8731.083236260229, 8756.693515726918, 616.4205646692185, 616.4852348289229, 640.6700549217157, 678.59284429342, 680.1396233764292, 4217.388478670576, 4374.759388233678, 4452.5992660660695, 4456.844010459618, 4492.213862574102, 54763.72618136964, 57661.423385766444, 88669.55665221633, 91553.54223228841, 94349.0, 58553.70723146357, 60166.69916650389, 69795.0, 83128.0, 84139.0, 63833.68083159647, 64122.35877641164, 65621.34378656247, 66993.0, 67313.66343168252, 8149.429539932148, 8351.331893448389, 9140.268778497837, 9308.534573271445, 9314.813703726024, 32487.67512324941, 40502.0, 41990.79004604957, 43203.35194972141, 45324.546754532035, 56619.71690141523, 57607.0, 62446.68776656088, 62943.37056629375, 63406.0, 11935.224210426642, 12009.760161875593, 12118.151729378858, 12149.0, 12174.0, 12457.314847683465, 12693.42879570403, 12842.165259258118, 12980.286084265455, 13047.543335983195, 11164.944175279072, 11205.159613028893, 11252.549898004316, 11293.491792869505, 11499.597514086967, 11841.407929603658, 12082.318655435445, 12187.146899716934, 12296.200746951778, 12410.069244806495, 11317.094632429551, 11734.70663233426, 11947.462364193805, 12011.393971932845, 12055.276683399024, 9669.371490853073, 9914.900850991398, 10054.798904022025, 10056.64801731936, 10192.337498062601, 9075.636974520945, 9153.93625239874, 9755.951220243853, 9857.852132218166, 9929.0], "value": 6679.612660264252, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 114.0, 114.0, 115.0, 113.0, 114.0, 115.0, 113.0, 116.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 125.0, 126.0, 173.0, 126.0, 124.0, 127.0, 126.0, 167.0, 126.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 166.0, 175.0, 163.0, 161.0, 163.0, 164.0, 163.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 107.0, 77.0, 76.0, 77.0, 77.0, 104.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 110.0, 84.0, 84.0, 83.0, 104.0, 83.0, 84.0, 109.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 119.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 149.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 86.0, 86.0, 85.0, 85.0, 86.0, 85.0, 85.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 54.0, 52.0, 51.0, 53.0, 53.0, 55.0, 55.0, 59.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 64.0, 65.0, 64.0, 63.0, 63.0, 63.0, 63.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 82.0, 80.0, 80.0, 81.0, 82.0, 82.0, 81.0, 89.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 134.0, 138.0, 146.0, 148.0, 141.0, 131.0, 187.0, 137.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 168.0, 167.0, 177.0, 173.0, 164.0, 164.0, 169.0, 166.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 65.0, 64.0, 66.0, 65.0, 64.0, 64.0, 66.0, 63.0], "value": 65.1, "unit": "score"}]}]} 06:12:46 INFO - Return code: 0 06:12:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:12:46 ERROR - # TBPL SUCCESS # 06:12:46 INFO - Running post-action listener: _resource_record_post_action 06:12:46 INFO - [mozharness: 2016-11-11 14:12:46.476809Z] Finished run-tests step (success) 06:12:46 INFO - Running post-run listener: _resource_record_post_run 06:12:46 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392187904; Read time: 16; Write time: 233428 06:12:46 INFO - TinderboxPrint: CPU usage
13.4% 06:12:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 06:12:46 INFO - TinderboxPrint: I/O write bytes / time
392,187,904 / 233,428 06:12:46 INFO - TinderboxPrint: CPU idle
8,254.1 (86.6%) 06:12:46 INFO - TinderboxPrint: CPU user
1,213.5 (12.7%) 06:12:46 INFO - TinderboxPrint: Swap in / out
0 / 0 06:12:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103522304; Read time: 0; Write time: 61008 06:12:46 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 288305152; Read time: 0; Write time: 172376 06:12:47 INFO - Running post-run listener: _upload_blobber_files 06:12:47 INFO - Blob upload gear active. 06:12:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:12:47 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 06:12:47 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'] 06:12:47 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 06:12:47 INFO - (blobuploader) - INFO - Open directory for files ... 06:12:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:12:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:12:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:48 INFO - (blobuploader) - INFO - Done attempting. 06:12:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:12:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:12:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:51 INFO - (blobuploader) - INFO - Done attempting. 06:12:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:12:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:12:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:52 INFO - (blobuploader) - INFO - Done attempting. 06:12:52 INFO - (blobuploader) - INFO - Iteration through files over. 06:12:52 INFO - Return code: 0 06:12:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:12:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:12:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb152c6e2e01650d01ce208f3808f911572885737bed78585271854da24e6c50881a521cc661b67915911bba6f64057d38ac941715523aeb7216fa20be193324", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e0387eb3e3c88884675caf2d38e06b453f4372c2dc8156663fe4a9ab74be9ea8e4685e455e33a4413fe33bcc55a6e883ced19299592d922470ba3575891300d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6c279d7f73d21fb9d9ca404f03eae6abe5424bae1c7542fb58e919c072bb96fda9d3230223fdaddef0df4216d500cd883e1bf41e3946329ec125221f28ad3db"} 06:12:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:12:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:12:52 INFO - Contents: 06:12:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb152c6e2e01650d01ce208f3808f911572885737bed78585271854da24e6c50881a521cc661b67915911bba6f64057d38ac941715523aeb7216fa20be193324", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e0387eb3e3c88884675caf2d38e06b453f4372c2dc8156663fe4a9ab74be9ea8e4685e455e33a4413fe33bcc55a6e883ced19299592d922470ba3575891300d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6c279d7f73d21fb9d9ca404f03eae6abe5424bae1c7542fb58e919c072bb96fda9d3230223fdaddef0df4216d500cd883e1bf41e3946329ec125221f28ad3db"} 06:12:52 INFO - Running post-run listener: copy_logs_to_upload_dir 06:12:52 INFO - Copying logs to upload dir... 06:12:52 INFO - mkdir: /builds/slave/test/build/upload/logs 06:12:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.300346 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-11 06:12:51.221964) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 06:12:51.225683) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136 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/eb152c6e2e01650d01ce208f3808f911572885737bed78585271854da24e6c50881a521cc661b67915911bba6f64057d38ac941715523aeb7216fa20be193324", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e0387eb3e3c88884675caf2d38e06b453f4372c2dc8156663fe4a9ab74be9ea8e4685e455e33a4413fe33bcc55a6e883ced19299592d922470ba3575891300d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6c279d7f73d21fb9d9ca404f03eae6abe5424bae1c7542fb58e919c072bb96fda9d3230223fdaddef0df4216d500cd883e1bf41e3946329ec125221f28ad3db"} build_url:https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb152c6e2e01650d01ce208f3808f911572885737bed78585271854da24e6c50881a521cc661b67915911bba6f64057d38ac941715523aeb7216fa20be193324", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e0387eb3e3c88884675caf2d38e06b453f4372c2dc8156663fe4a9ab74be9ea8e4685e455e33a4413fe33bcc55a6e883ced19299592d922470ba3575891300d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6c279d7f73d21fb9d9ca404f03eae6abe5424bae1c7542fb58e919c072bb96fda9d3230223fdaddef0df4216d500cd883e1bf41e3946329ec125221f28ad3db"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 06:12:51.253759) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 06:12:51.254331) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1478871537.866339-541727136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 06:12:51.338287) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 06:12:51.338598) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 06:12:51.338901) ========= ========= Total master_lag: 0.17 =========