builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1480002397.94 results: success (0) buildid: 20161124062519 builduid: 29d967c35a674ee58c56f902dc8c8181 revision: 8332d69f0f65b0c2612338d86fc69d58ab70c318 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 07:46:37.935933) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 07:46:37.936418) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 07:46:37.936754) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 07:46:37.951473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 07:46:37.951775) ========= 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=232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-24 07:46:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 95.5M=0s 2016-11-24 07:46:38 (95.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090923 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 07:46:38.062456) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 07:46:38.062770) ========= 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=232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013277 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 07:46:38.112753) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-24 07:46:38.113281) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8332d69f0f65b0c2612338d86fc69d58ab70c318 --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 8332d69f0f65b0c2612338d86fc69d58ab70c318 --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=232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-24 07:46:38,259 truncating revision to first 12 chars 2016-11-24 07:46:38,259 Setting DEBUG logging. 2016-11-24 07:46:38,259 attempt 1/10 2016-11-24 07:46:38,259 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8332d69f0f65?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-24 07:46:39,297 unpacking tar archive at: mozilla-central-8332d69f0f65/testing/mozharness/ program finished with exit code 0 elapsedTime=1.415010 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-24 07:46:39.542803) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 07:46:39.543394) ========= script_repo_revision: 8332d69f0f65b0c2612338d86fc69d58ab70c318 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 07:46:39.544083) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 07:46:39.544647) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 07:46:39.554697) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-24 07:46:39.555162) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:46:39 INFO - MultiFileLogger online at 20161124 07:46:39 in /builds/slave/test 07:46:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:46:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:46:39 INFO - {'append_to_log': False, 07:46:39 INFO - 'base_work_dir': '/builds/slave/test', 07:46:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:46:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:46:39 INFO - 'branch': 'Firefox-Non-PGO', 07:46:39 INFO - 'buildbot_json_path': 'buildprops.json', 07:46:39 INFO - 'config_files': ('talos/linux_config.py',), 07:46:39 INFO - 'default_actions': ('clobber', 07:46:39 INFO - 'read-buildbot-config', 07:46:39 INFO - 'download-and-extract', 07:46:39 INFO - 'populate-webroot', 07:46:39 INFO - 'create-virtualenv', 07:46:39 INFO - 'install', 07:46:39 INFO - 'run-tests'), 07:46:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:46:39 INFO - 'download_minidump_stackwalk': True, 07:46:39 INFO - 'download_symbols': 'ondemand', 07:46:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:46:39 INFO - 'tooltool.py': '/tools/tooltool.py', 07:46:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:46:39 INFO - '/tools/misc-python/virtualenv.py')}, 07:46:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:46:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:46:39 INFO - 'installer_path': 'installer.exe', 07:46:39 INFO - 'log_level': 'info', 07:46:39 INFO - 'log_name': 'talos', 07:46:39 INFO - 'log_to_console': True, 07:46:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:46:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:46:39 INFO - 'opt_config_files': (), 07:46:39 INFO - 'pip_index': False, 07:46:39 INFO - 'sps_profile': False, 07:46:39 INFO - 'sps_profile_interval': 0, 07:46:39 INFO - 'suite': 'dromaeojs', 07:46:39 INFO - 'system_bits': '32', 07:46:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:46:39 INFO - 'title': 'talos-linux64-ix-025', 07:46:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:46:39 INFO - 'use_talos_json': True, 07:46:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:46:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:46:39 INFO - 'work_dir': 'build'} 07:46:39 INFO - [mozharness: 2016-11-24 15:46:39.795046Z] Running clobber step. 07:46:39 INFO - Running pre-action listener: _resource_record_pre_action 07:46:39 INFO - Running main action method: clobber 07:46:39 INFO - rmtree: /builds/slave/test/build 07:46:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:46:40 INFO - Running post-action listener: _resource_record_post_action 07:46:40 INFO - [mozharness: 2016-11-24 15:46:40.769824Z] Finished clobber step (success) 07:46:40 INFO - [mozharness: 2016-11-24 15:46:40.769922Z] Running read-buildbot-config step. 07:46:40 INFO - Running pre-action listener: _resource_record_pre_action 07:46:40 INFO - Running main action method: read_buildbot_config 07:46:40 INFO - Using buildbot properties: 07:46:40 INFO - { 07:46:40 INFO - "project": "", 07:46:40 INFO - "product": "firefox", 07:46:40 INFO - "script_repo_revision": "production", 07:46:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:46:40 INFO - "repository": "", 07:46:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:46:40 INFO - "buildid": "20161124062519", 07:46:40 INFO - "pgo_build": "False", 07:46:40 INFO - "basedir": "/builds/slave/test", 07:46:40 INFO - "buildnumber": 829, 07:46:40 INFO - "slavename": "talos-linux64-ix-025", 07:46:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:46:40 INFO - "platform": "ubuntu64_hw", 07:46:40 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:46:40 INFO - "branch": "mozilla-central", 07:46:40 INFO - "repo_path": "mozilla-central", 07:46:40 INFO - "revision": "8332d69f0f65b0c2612338d86fc69d58ab70c318", 07:46:40 INFO - "stage_platform": "linux64", 07:46:40 INFO - "builduid": "29d967c35a674ee58c56f902dc8c8181", 07:46:40 INFO - "slavebuilddir": "test" 07:46:40 INFO - } 07:46:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:46:40 INFO - Running post-action listener: _resource_record_post_action 07:46:40 INFO - [mozharness: 2016-11-24 15:46:40.772325Z] Finished read-buildbot-config step (success) 07:46:40 INFO - [mozharness: 2016-11-24 15:46:40.772413Z] Running download-and-extract step. 07:46:40 INFO - Running pre-action listener: _resource_record_pre_action 07:46:40 INFO - Running main action method: download_and_extract 07:46:40 INFO - mkdir: /builds/slave/test/build/tests 07:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:40 INFO - trying https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:46:40 INFO - Downloading https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:46:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:46:41 INFO - Downloaded 1361 bytes. 07:46:41 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:46:41 INFO - Using the following test package requirements: 07:46:41 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:46:41 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:46:41 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:46:41 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:41 INFO - u'jsshell-linux-x86_64.zip'], 07:46:41 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:46:41 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:46:41 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:46:41 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:46:41 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:46:41 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:46:41 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:46:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:46:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:46:41 INFO - Fetch https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:46:41 INFO - Http code: 200 07:46:41 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 07:46:41 INFO - x-amz-cf-id: K4kgfgvZkAjWryYhPUfHQPYEHd6wfbqfasa36IQiuxeqeNwZkrNx0g== 07:46:41 INFO - x-amz-version-id: r3ykSgKs4z9XWiqkkIPq8kF6POSGHk._ 07:46:42 INFO - Expected file size: 20202634 07:46:42 INFO - Obtained file size: 20202634 07:46:46 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:46:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:46:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:46:46 INFO - Fetch https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:46:46 INFO - Http code: 200 07:46:46 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 07:46:46 INFO - x-amz-cf-id: vH6khpWPh3RnyP4aYfx9rRHgUVrkg-iBZilk4LYefSqSoPWsW300OA== 07:46:46 INFO - x-amz-version-id: r3ykSgKs4z9XWiqkkIPq8kF6POSGHk._ 07:46:47 INFO - Expected file size: 20202634 07:46:47 INFO - Obtained file size: 20202634 07:46:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:46:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:46:51 INFO - Fetch https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:46:52 INFO - Http code: 200 07:46:52 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 07:46:52 INFO - x-amz-cf-id: 7Ur6foPLfYOYojQRiCcYN7w1cdTyXB8-i6vmWZCMlLg6q6m2GupG9g== 07:46:52 INFO - x-amz-version-id: oYQ.kXIPmvPtmdJrTs1.fuuliOxxl4Ei 07:46:52 INFO - Expected file size: 14409749 07:46:52 INFO - Obtained file size: 14409749 07:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:52 INFO - trying https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:46:52 INFO - Downloading https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:46:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:46:53 INFO - Downloaded 55583421 bytes. 07:46:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:46:53 INFO - mkdir: /builds/slave/test/properties 07:46:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:46:53 INFO - Writing to file /builds/slave/test/properties/build_url 07:46:53 INFO - Contents: 07:46:53 INFO - build_url:https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:46:54 INFO - Running post-action listener: _resource_record_post_action 07:46:54 INFO - Running post-action listener: set_extra_try_arguments 07:46:54 INFO - [mozharness: 2016-11-24 15:46:54.491299Z] Finished download-and-extract step (success) 07:46:54 INFO - [mozharness: 2016-11-24 15:46:54.491523Z] Running populate-webroot step. 07:46:54 INFO - Running pre-action listener: _resource_record_pre_action 07:46:54 INFO - Running main action method: populate_webroot 07:46:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:46:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:46:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:46:54 INFO - '--tppagecycles', 07:46:54 INFO - '7'], 07:46:54 INFO - 'tests': ['tsvgm']}}, 07:46:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:46:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:46:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:46:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:46:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:46:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:46:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:46:54 INFO - 'talos_options': ['--disable-e10s'], 07:46:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:46:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:46:54 INFO - 'talos_options': ['--disable-e10s'], 07:46:54 INFO - 'tests': ['damp', 'tps']}, 07:46:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:46:54 INFO - 'tests': ['damp', 'tps']}, 07:46:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:46:54 INFO - 'tests': ['dromaeo_dom']}, 07:46:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:46:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:46:54 INFO - 'tests': ['basic_compositor_video']}, 07:46:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:46:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:46:54 INFO - 'tests': ['a11yr', 07:46:54 INFO - 'ts_paint', 07:46:54 INFO - 'tpaint', 07:46:54 INFO - 'sessionrestore', 07:46:54 INFO - 'sessionrestore_no_auto_restore', 07:46:54 INFO - 'tabpaint']}, 07:46:54 INFO - 'other-e10s': {'tests': ['a11yr', 07:46:54 INFO - 'ts_paint', 07:46:54 INFO - 'tpaint', 07:46:54 INFO - 'sessionrestore', 07:46:54 INFO - 'sessionrestore_no_auto_restore', 07:46:54 INFO - 'tabpaint']}, 07:46:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:46:54 INFO - 'ts_paint', 07:46:54 INFO - 'tpaint', 07:46:54 INFO - 'sessionrestore', 07:46:54 INFO - 'sessionrestore_no_auto_restore', 07:46:54 INFO - 'tabpaint']}, 07:46:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:46:54 INFO - 'ts_paint', 07:46:54 INFO - 'tpaint', 07:46:54 INFO - 'sessionrestore', 07:46:54 INFO - 'sessionrestore_no_auto_restore', 07:46:54 INFO - 'tabpaint']}, 07:46:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:46:54 INFO - 'tests': ['a11yr', 07:46:54 INFO - 'ts_paint', 07:46:54 INFO - 'tpaint', 07:46:54 INFO - 'sessionrestore', 07:46:54 INFO - 'sessionrestore_no_auto_restore', 07:46:54 INFO - 'tabpaint']}, 07:46:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:46:54 INFO - 'tests': ['a11yr', 07:46:54 INFO - 'ts_paint', 07:46:54 INFO - 'tpaint', 07:46:54 INFO - 'sessionrestore', 07:46:54 INFO - 'sessionrestore_no_auto_restore', 07:46:54 INFO - 'tabpaint']}, 07:46:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:46:54 INFO - 'tests': ['tsvgx', 07:46:54 INFO - 'tsvgr_opacity', 07:46:54 INFO - 'tart', 07:46:54 INFO - 'tscrollx', 07:46:54 INFO - 'cart', 07:46:54 INFO - 'tsvg_static']}, 07:46:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:46:54 INFO - 'tsvgr_opacity', 07:46:54 INFO - 'tart', 07:46:54 INFO - 'tscrollx', 07:46:54 INFO - 'cart', 07:46:54 INFO - 'tsvg_static']}, 07:46:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:46:54 INFO - 'talos_options': ['--disable-e10s'], 07:46:54 INFO - 'tests': ['tp5o']}, 07:46:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:46:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:46:54 INFO - 'talos_options': ['--disable-e10s', 07:46:54 INFO - '--xperf_path', 07:46:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:54 INFO - 'tests': ['tp5n']}, 07:46:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:46:54 INFO - 'talos_options': ['--xperf_path', 07:46:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:54 INFO - 'tests': ['tp5n']}}, 07:46:54 INFO - 'talos.zip': {'path': '', 07:46:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:46:54 INFO - Running post-action listener: _resource_record_post_action 07:46:54 INFO - [mozharness: 2016-11-24 15:46:54.511430Z] Finished populate-webroot step (success) 07:46:54 INFO - [mozharness: 2016-11-24 15:46:54.511517Z] Running create-virtualenv step. 07:46:54 INFO - Running pre-action listener: _resource_record_pre_action 07:46:54 INFO - Running main action method: create_virtualenv 07:46:54 INFO - Creating virtualenv /builds/slave/test/build/venv 07:46:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:46:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:46:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:46:54 INFO - Using real prefix '/usr' 07:46:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:46:55 INFO - Installing distribute.............................................................................................................................................................................................done. 07:46:57 INFO - Installing pip.................done. 07:46:57 INFO - Return code: 0 07:46:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:46:57 INFO - Reading from file tmpfile_stdout 07:46:57 INFO - Output received: 07:46:57 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) 07:46:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f03d68ebe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2266b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490fc0>, '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 0x2491ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492350>, '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': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', '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 07:46:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:46:57 INFO - Using env: {'DISPLAY': ':0', 07:46:57 INFO - 'HOME': '/home/cltbld', 07:46:57 INFO - 'LANG': 'en_US.UTF-8', 07:46:57 INFO - 'LANGUAGE': 'en_US:en', 07:46:57 INFO - 'LOGNAME': 'cltbld', 07:46:57 INFO - 'MAIL': '/var/mail/cltbld', 07:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:57 INFO - 'MOZ_NO_REMOTE': '1', 07:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:57 INFO - 'NO_EM_RESTART': '1', 07:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:57 INFO - 'PWD': '/builds/slave/test', 07:46:57 INFO - 'SHELL': '/bin/bash', 07:46:57 INFO - 'SHLVL': '1', 07:46:57 INFO - 'TERM': 'linux', 07:46:57 INFO - 'TMOUT': '86400', 07:46:57 INFO - 'USER': 'cltbld', 07:46:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', 07:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:57 INFO - '_': '/tools/buildbot/bin/python'} 07:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:46:57 INFO - Cleaning up... 07:46:57 INFO - Return code: 0 07:46:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f03d68ebe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2266b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490fc0>, '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 0x2491ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492350>, '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': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', '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 07:46:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:46:57 INFO - Using env: {'DISPLAY': ':0', 07:46:57 INFO - 'HOME': '/home/cltbld', 07:46:57 INFO - 'LANG': 'en_US.UTF-8', 07:46:57 INFO - 'LANGUAGE': 'en_US:en', 07:46:57 INFO - 'LOGNAME': 'cltbld', 07:46:57 INFO - 'MAIL': '/var/mail/cltbld', 07:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:57 INFO - 'MOZ_NO_REMOTE': '1', 07:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:57 INFO - 'NO_EM_RESTART': '1', 07:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:57 INFO - 'PWD': '/builds/slave/test', 07:46:57 INFO - 'SHELL': '/bin/bash', 07:46:57 INFO - 'SHLVL': '1', 07:46:57 INFO - 'TERM': 'linux', 07:46:57 INFO - 'TMOUT': '86400', 07:46:57 INFO - 'USER': 'cltbld', 07:46:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', 07:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:57 INFO - '_': '/tools/buildbot/bin/python'} 07:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:57 INFO - Downloading/unpacking psutil>=3.1.1 07:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:46:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:59 INFO - Installing collected packages: psutil 07:46:59 INFO - Running setup.py install for psutil 07:46:59 INFO - building 'psutil._psutil_linux' extension 07:46:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:47:00 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 07:47:00 INFO - building 'psutil._psutil_posix' extension 07:47:00 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 07:47:00 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 07:47:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:47:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:47:00 INFO - Successfully installed psutil 07:47:00 INFO - Cleaning up... 07:47:00 INFO - Return code: 0 07:47:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:47:00 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')]} 07:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:00 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')]} 07:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:00 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 0x7f03d68ebe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2266b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490fc0>, '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 0x2491ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492350>, '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': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', '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 07:47:00 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 07:47:00 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 07:47:00 INFO - Using env: {'DISPLAY': ':0', 07:47:00 INFO - 'HOME': '/home/cltbld', 07:47:00 INFO - 'LANG': 'en_US.UTF-8', 07:47:00 INFO - 'LANGUAGE': 'en_US:en', 07:47:00 INFO - 'LOGNAME': 'cltbld', 07:47:00 INFO - 'MAIL': '/var/mail/cltbld', 07:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:00 INFO - 'MOZ_NO_REMOTE': '1', 07:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:00 INFO - 'NO_EM_RESTART': '1', 07:47:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:00 INFO - 'PWD': '/builds/slave/test', 07:47:00 INFO - 'SHELL': '/bin/bash', 07:47:00 INFO - 'SHLVL': '1', 07:47:00 INFO - 'TERM': 'linux', 07:47:00 INFO - 'TMOUT': '86400', 07:47:00 INFO - 'USER': 'cltbld', 07:47:00 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', 07:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:00 INFO - '_': '/tools/buildbot/bin/python'} 07:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:47:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:47:02 INFO - Installing collected packages: mozsystemmonitor 07:47:02 INFO - Running setup.py install for mozsystemmonitor 07:47:02 INFO - Successfully installed mozsystemmonitor 07:47:02 INFO - Cleaning up... 07:47:02 INFO - Return code: 0 07:47:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f03d68ebe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2266b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490fc0>, '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 0x2491ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492350>, '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': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', '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 07:47:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:47:02 INFO - Using env: {'DISPLAY': ':0', 07:47:02 INFO - 'HOME': '/home/cltbld', 07:47:02 INFO - 'LANG': 'en_US.UTF-8', 07:47:02 INFO - 'LANGUAGE': 'en_US:en', 07:47:02 INFO - 'LOGNAME': 'cltbld', 07:47:02 INFO - 'MAIL': '/var/mail/cltbld', 07:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:02 INFO - 'MOZ_NO_REMOTE': '1', 07:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:02 INFO - 'NO_EM_RESTART': '1', 07:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:02 INFO - 'PWD': '/builds/slave/test', 07:47:02 INFO - 'SHELL': '/bin/bash', 07:47:02 INFO - 'SHLVL': '1', 07:47:02 INFO - 'TERM': 'linux', 07:47:02 INFO - 'TMOUT': '86400', 07:47:02 INFO - 'USER': 'cltbld', 07:47:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', 07:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:02 INFO - '_': '/tools/buildbot/bin/python'} 07:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:02 INFO - Downloading/unpacking jsonschema==2.5.1 07:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:47:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:05 INFO - Downloading functools32-3.2.3-2.tar.gz 07:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:47:05 INFO - warning: no files found matching '*.txt' 07:47:05 INFO - no previously-included directories found matching 'build' 07:47:05 INFO - no previously-included directories found matching 'dist' 07:47:05 INFO - no previously-included directories found matching '.git*' 07:47:05 INFO - Installing collected packages: jsonschema, functools32 07:47:05 INFO - Running setup.py install for functools32 07:47:05 INFO - warning: no files found matching '*.txt' 07:47:05 INFO - no previously-included directories found matching 'build' 07:47:05 INFO - no previously-included directories found matching 'dist' 07:47:05 INFO - no previously-included directories found matching '.git*' 07:47:05 INFO - Successfully installed jsonschema functools32 07:47:05 INFO - Cleaning up... 07:47:05 INFO - Return code: 0 07:47:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f03d68ebe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2266b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490fc0>, '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 0x2491ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492350>, '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': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', '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 07:47:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:47:05 INFO - Using env: {'DISPLAY': ':0', 07:47:05 INFO - 'HOME': '/home/cltbld', 07:47:05 INFO - 'LANG': 'en_US.UTF-8', 07:47:05 INFO - 'LANGUAGE': 'en_US:en', 07:47:05 INFO - 'LOGNAME': 'cltbld', 07:47:05 INFO - 'MAIL': '/var/mail/cltbld', 07:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:05 INFO - 'MOZ_NO_REMOTE': '1', 07:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:05 INFO - 'NO_EM_RESTART': '1', 07:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:05 INFO - 'PWD': '/builds/slave/test', 07:47:05 INFO - 'SHELL': '/bin/bash', 07:47:05 INFO - 'SHLVL': '1', 07:47:05 INFO - 'TERM': 'linux', 07:47:05 INFO - 'TMOUT': '86400', 07:47:05 INFO - 'USER': 'cltbld', 07:47:05 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', 07:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:05 INFO - '_': '/tools/buildbot/bin/python'} 07:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:47:05 INFO - Cleaning up... 07:47:05 INFO - Return code: 0 07:47:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f03d68ebe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2266b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490fc0>, '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 0x2491ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492350>, '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': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', '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 07:47:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:47:05 INFO - Using env: {'DISPLAY': ':0', 07:47:05 INFO - 'HOME': '/home/cltbld', 07:47:05 INFO - 'LANG': 'en_US.UTF-8', 07:47:05 INFO - 'LANGUAGE': 'en_US:en', 07:47:05 INFO - 'LOGNAME': 'cltbld', 07:47:05 INFO - 'MAIL': '/var/mail/cltbld', 07:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:05 INFO - 'MOZ_NO_REMOTE': '1', 07:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:05 INFO - 'NO_EM_RESTART': '1', 07:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:05 INFO - 'PWD': '/builds/slave/test', 07:47:05 INFO - 'SHELL': '/bin/bash', 07:47:05 INFO - 'SHLVL': '1', 07:47:05 INFO - 'TERM': 'linux', 07:47:05 INFO - 'TMOUT': '86400', 07:47:05 INFO - 'USER': 'cltbld', 07:47:05 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', 07:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:05 INFO - '_': '/tools/buildbot/bin/python'} 07:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:05 INFO - Downloading/unpacking blobuploader==1.2.4 07:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:07 INFO - Downloading blobuploader-1.2.4.tar.gz 07:47:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:47:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:47:08 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 07:47:08 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 07:47:08 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 07:47:08 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 07:47:08 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 07:47:08 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 07:47:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:47:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:47:08 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 07:47:08 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 07:47:08 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 07:47:08 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 07:47:08 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 07:47:08 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 07:47:08 INFO - Downloading docopt-0.6.1.tar.gz 07:47:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:47:08 INFO - Installing collected packages: blobuploader, requests, docopt 07:47:08 INFO - Running setup.py install for blobuploader 07:47:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:47:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:47:08 INFO - Running setup.py install for requests 07:47:09 INFO - Running setup.py install for docopt 07:47:09 INFO - Successfully installed blobuploader requests docopt 07:47:09 INFO - Cleaning up... 07:47:09 INFO - Return code: 0 07:47:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:09 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')]} 07:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:09 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')]} 07:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:09 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 0x7f03d68ebe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2266b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490fc0>, '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 0x2491ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492350>, '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': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', '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 07:47:09 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 07:47:09 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 07:47:09 INFO - Using env: {'DISPLAY': ':0', 07:47:09 INFO - 'HOME': '/home/cltbld', 07:47:09 INFO - 'LANG': 'en_US.UTF-8', 07:47:09 INFO - 'LANGUAGE': 'en_US:en', 07:47:09 INFO - 'LOGNAME': 'cltbld', 07:47:09 INFO - 'MAIL': '/var/mail/cltbld', 07:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:09 INFO - 'MOZ_NO_REMOTE': '1', 07:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:09 INFO - 'NO_EM_RESTART': '1', 07:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:09 INFO - 'PWD': '/builds/slave/test', 07:47:09 INFO - 'SHELL': '/bin/bash', 07:47:09 INFO - 'SHLVL': '1', 07:47:09 INFO - 'TERM': 'linux', 07:47:09 INFO - 'TMOUT': '86400', 07:47:09 INFO - 'USER': 'cltbld', 07:47:09 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', 07:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:09 INFO - '_': '/tools/buildbot/bin/python'} 07:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:09 INFO - Running setup.py (path:/tmp/pip-HBplZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:09 INFO - Running setup.py (path:/tmp/pip-3soim2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:09 INFO - Running setup.py (path:/tmp/pip-wag1vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:09 INFO - Running setup.py (path:/tmp/pip-6Mdm50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:09 INFO - Running setup.py (path:/tmp/pip-XshgXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:09 INFO - Running setup.py (path:/tmp/pip-90A9ZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:10 INFO - Running setup.py (path:/tmp/pip-iXNIFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:47:10 INFO - Running setup.py (path:/tmp/pip-n2OkVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:10 INFO - Running setup.py (path:/tmp/pip-KgegO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:10 INFO - Running setup.py (path:/tmp/pip-4kIlBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:10 INFO - Running setup.py (path:/tmp/pip-wWhqYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:10 INFO - Running setup.py (path:/tmp/pip-tfvZKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:10 INFO - Running setup.py (path:/tmp/pip-aczPVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:10 INFO - Running setup.py (path:/tmp/pip-wJlBwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:10 INFO - Running setup.py (path:/tmp/pip-YTRJHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:10 INFO - Running setup.py (path:/tmp/pip-fDKd3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:10 INFO - Running setup.py (path:/tmp/pip-45g8kL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:47:10 INFO - Running setup.py install for manifestparser 07:47:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:47:10 INFO - Running setup.py install for mozcrash 07:47:11 INFO - Running setup.py install for mozdebug 07:47:11 INFO - Running setup.py install for mozdevice 07:47:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:47:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:47:11 INFO - Running setup.py install for mozfile 07:47:11 INFO - Running setup.py install for mozhttpd 07:47:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:47:11 INFO - Running setup.py install for mozinfo 07:47:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:47:11 INFO - Running setup.py install for mozInstall 07:47:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:47:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:47:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:47:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:47:11 INFO - Running setup.py install for mozleak 07:47:11 INFO - Running setup.py install for mozlog 07:47:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:47:11 INFO - Running setup.py install for moznetwork 07:47:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:47:11 INFO - Running setup.py install for mozprocess 07:47:12 INFO - Running setup.py install for mozprofile 07:47:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:47:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:47:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:47:12 INFO - Running setup.py install for mozrunner 07:47:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:47:12 INFO - Running setup.py install for mozscreenshot 07:47:12 INFO - Running setup.py install for moztest 07:47:12 INFO - Running setup.py install for mozversion 07:47:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:47:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:47:12 INFO - Cleaning up... 07:47:12 INFO - Return code: 0 07:47:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:12 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')]} 07:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:12 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')]} 07:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:12 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 0x7f03d68ebe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2266b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490fc0>, '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 0x2491ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492350>, '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': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', '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 07:47:12 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 07:47:12 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 07:47:12 INFO - Using env: {'DISPLAY': ':0', 07:47:12 INFO - 'HOME': '/home/cltbld', 07:47:12 INFO - 'LANG': 'en_US.UTF-8', 07:47:12 INFO - 'LANGUAGE': 'en_US:en', 07:47:12 INFO - 'LOGNAME': 'cltbld', 07:47:12 INFO - 'MAIL': '/var/mail/cltbld', 07:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:12 INFO - 'MOZ_NO_REMOTE': '1', 07:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:12 INFO - 'NO_EM_RESTART': '1', 07:47:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:12 INFO - 'PWD': '/builds/slave/test', 07:47:12 INFO - 'SHELL': '/bin/bash', 07:47:12 INFO - 'SHLVL': '1', 07:47:12 INFO - 'TERM': 'linux', 07:47:12 INFO - 'TMOUT': '86400', 07:47:12 INFO - 'USER': 'cltbld', 07:47:12 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', 07:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:12 INFO - '_': '/tools/buildbot/bin/python'} 07:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:12 INFO - Running setup.py (path:/tmp/pip-lbR84C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:12 INFO - Running setup.py (path:/tmp/pip-EWf3qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:12 INFO - Running setup.py (path:/tmp/pip-b_ExOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47:13 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)) 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:13 INFO - Running setup.py (path:/tmp/pip-hRfwKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:13 INFO - Running setup.py (path:/tmp/pip-zNE5N1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47:13 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)) 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:13 INFO - Running setup.py (path:/tmp/pip-SuPge1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:13 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)) 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:13 INFO - Running setup.py (path:/tmp/pip-93CtGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:47:13 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)) 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:47:13 INFO - Running setup.py (path:/tmp/pip-TzGqMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:13 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)) 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:13 INFO - Running setup.py (path:/tmp/pip-kHNW34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47:13 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)) 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:13 INFO - Running setup.py (path:/tmp/pip-SoCRfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47:13 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)) 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:13 INFO - Running setup.py (path:/tmp/pip-H6vhOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47:13 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)) 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:13 INFO - Running setup.py (path:/tmp/pip-7qsrfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:13 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)) 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:13 INFO - Running setup.py (path:/tmp/pip-sqjPQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:13 INFO - Running setup.py (path:/tmp/pip-mih8wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:13 INFO - Running setup.py (path:/tmp/pip-2PoUli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:13 INFO - Running setup.py (path:/tmp/pip-dic0o3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:13 INFO - Running setup.py (path:/tmp/pip-1iwS3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:14 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)) 07:47:14 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)) 07:47:14 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)) 07:47:14 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)) 07:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:47:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:47:14 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 07:47:14 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 07:47:14 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 07:47:14 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 07:47:14 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 07:47:14 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 07:47:16 INFO - Downloading blessings-1.6.tar.gz 07:47:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:47:16 INFO - Installing collected packages: blessings 07:47:16 INFO - Running setup.py install for blessings 07:47:16 INFO - Successfully installed blessings 07:47:16 INFO - Cleaning up... 07:47:16 INFO - Return code: 0 07:47:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:47:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:16 INFO - Reading from file tmpfile_stdout 07:47:16 INFO - Current package versions: 07:47:16 INFO - argparse == 1.2.1 07:47:16 INFO - blessings == 1.6 07:47:16 INFO - blobuploader == 1.2.4 07:47:16 INFO - docopt == 0.6.1 07:47:16 INFO - functools32 == 3.2.3-2 07:47:16 INFO - jsonschema == 2.5.1 07:47:16 INFO - manifestparser == 1.1 07:47:16 INFO - mozInstall == 1.12 07:47:16 INFO - mozcrash == 1.0 07:47:16 INFO - mozdebug == 0.1 07:47:16 INFO - mozdevice == 0.49 07:47:16 INFO - mozfile == 1.2 07:47:16 INFO - mozhttpd == 0.7 07:47:16 INFO - mozinfo == 0.9 07:47:16 INFO - mozleak == 0.1 07:47:16 INFO - mozlog == 3.4 07:47:16 INFO - moznetwork == 0.27 07:47:16 INFO - mozprocess == 0.23 07:47:16 INFO - mozprofile == 0.28 07:47:16 INFO - mozrunner == 6.13 07:47:16 INFO - mozscreenshot == 0.1 07:47:16 INFO - mozsystemmonitor == 0.3 07:47:16 INFO - moztest == 0.7 07:47:16 INFO - mozversion == 1.4 07:47:16 INFO - psutil == 3.1.1 07:47:16 INFO - requests == 1.2.3 07:47:16 INFO - wsgiref == 0.1.2 07:47:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:16 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 0x7f03d68ebe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2266b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490fc0>, '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 0x2491ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492350>, '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': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', '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 07:47:16 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 07:47:16 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 07:47:16 INFO - Using env: {'DISPLAY': ':0', 07:47:16 INFO - 'HOME': '/home/cltbld', 07:47:16 INFO - 'LANG': 'en_US.UTF-8', 07:47:16 INFO - 'LANGUAGE': 'en_US:en', 07:47:16 INFO - 'LOGNAME': 'cltbld', 07:47:16 INFO - 'MAIL': '/var/mail/cltbld', 07:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:16 INFO - 'MOZ_NO_REMOTE': '1', 07:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:16 INFO - 'NO_EM_RESTART': '1', 07:47:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:16 INFO - 'PWD': '/builds/slave/test', 07:47:16 INFO - 'SHELL': '/bin/bash', 07:47:16 INFO - 'SHLVL': '1', 07:47:16 INFO - 'TERM': 'linux', 07:47:16 INFO - 'TMOUT': '86400', 07:47:16 INFO - 'USER': 'cltbld', 07:47:16 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', 07:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:16 INFO - '_': '/tools/buildbot/bin/python'} 07:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:16 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)) 07:47:16 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)) 07:47:16 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)) 07:47:16 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)) 07:47:16 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)) 07:47:16 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)) 07:47:16 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)) 07:47:16 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)) 07:47:16 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)) 07:47:16 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)) 07:47:16 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)) 07:47:16 INFO - Cleaning up... 07:47:16 INFO - Return code: 0 07:47:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:47:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:16 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 0x7f03d68ebe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2266b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490fc0>, '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 0x2491ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492350>, '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': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', '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 07:47:16 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 07:47:16 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 07:47:16 INFO - Using env: {'DISPLAY': ':0', 07:47:16 INFO - 'HOME': '/home/cltbld', 07:47:16 INFO - 'LANG': 'en_US.UTF-8', 07:47:16 INFO - 'LANGUAGE': 'en_US:en', 07:47:16 INFO - 'LOGNAME': 'cltbld', 07:47:16 INFO - 'MAIL': '/var/mail/cltbld', 07:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:16 INFO - 'MOZ_NO_REMOTE': '1', 07:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:16 INFO - 'NO_EM_RESTART': '1', 07:47:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:16 INFO - 'PWD': '/builds/slave/test', 07:47:16 INFO - 'SHELL': '/bin/bash', 07:47:16 INFO - 'SHLVL': '1', 07:47:16 INFO - 'TERM': 'linux', 07:47:16 INFO - 'TMOUT': '86400', 07:47:16 INFO - 'USER': 'cltbld', 07:47:16 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', 07:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:16 INFO - '_': '/tools/buildbot/bin/python'} 07:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:47:16 INFO - Cleaning up... 07:47:16 INFO - Return code: 0 07:47:16 INFO - Running post-action listener: _resource_record_post_action 07:47:16 INFO - Running post-action listener: _start_resource_monitoring 07:47:17 INFO - Starting resource monitoring. 07:47:17 INFO - [mozharness: 2016-11-24 15:47:17.006799Z] Finished create-virtualenv step (success) 07:47:17 INFO - [mozharness: 2016-11-24 15:47:17.007330Z] Running install step. 07:47:17 INFO - Running pre-action listener: _resource_record_pre_action 07:47:17 INFO - Running main action method: install 07:47:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:17 INFO - Reading from file tmpfile_stdout 07:47:17 INFO - Detecting whether we're running mozinstall >=1.0... 07:47:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:47:17 INFO - Reading from file tmpfile_stdout 07:47:17 INFO - Output received: 07:47:17 INFO - Usage: mozinstall [options] installer 07:47:17 INFO - Options: 07:47:17 INFO - -h, --help show this help message and exit 07:47:17 INFO - -d DEST, --destination=DEST 07:47:17 INFO - Directory to install application into. [default: 07:47:17 INFO - "/builds/slave/test"] 07:47:17 INFO - --app=APP Application being installed. [default: firefox] 07:47:17 INFO - mkdir: /builds/slave/test/build/application 07:47:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:47:33 INFO - Reading from file tmpfile_stdout 07:47:33 INFO - Output received: 07:47:33 INFO - /builds/slave/test/build/application/firefox/firefox 07:47:33 INFO - Running post-action listener: _resource_record_post_action 07:47:33 INFO - [mozharness: 2016-11-24 15:47:33.327084Z] Finished install step (success) 07:47:33 INFO - [mozharness: 2016-11-24 15:47:33.327323Z] Running run-tests step. 07:47:33 INFO - Running pre-action listener: _resource_record_pre_action 07:47:33 INFO - Running main action method: run_tests 07:47:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:47:33 INFO - Python 2.7.3 07:47:33 INFO - Return code: 0 07:47:33 INFO - grabbing minidump binary from tooltool 07:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490fc0>, '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 0x2491ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:47:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:47:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:47:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:47:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:47:33 INFO - Return code: 0 07:47:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:47:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:47:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:47:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:47:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:47:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:47:33 INFO - Using env: {'DISPLAY': ':0', 07:47:33 INFO - 'HOME': '/home/cltbld', 07:47:33 INFO - 'LANG': 'en_US.UTF-8', 07:47:33 INFO - 'LANGUAGE': 'en_US:en', 07:47:33 INFO - 'LOGNAME': 'cltbld', 07:47:33 INFO - 'MAIL': '/var/mail/cltbld', 07:47:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:47:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:33 INFO - 'MOZ_NO_REMOTE': '1', 07:47:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:47:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:33 INFO - 'NO_EM_RESTART': '1', 07:47:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:33 INFO - 'PWD': '/builds/slave/test', 07:47:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:47:33 INFO - 'SHELL': '/bin/bash', 07:47:33 INFO - 'SHLVL': '1', 07:47:33 INFO - 'TERM': 'linux', 07:47:33 INFO - 'TMOUT': '86400', 07:47:33 INFO - 'USER': 'cltbld', 07:47:33 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096', 07:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:33 INFO - '_': '/tools/buildbot/bin/python'} 07:47:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:47:33 INFO - mozversion application_buildid: 20161124062519 07:47:33 INFO - mozversion application_changeset: 8332d69f0f65b0c2612338d86fc69d58ab70c318 07:47:33 INFO - mozversion application_display_name: Nightly 07:47:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:47:33 INFO - mozversion application_name: Firefox 07:47:33 INFO - mozversion application_remotingname: firefox 07:47:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:47:33 INFO - mozversion application_vendor: Mozilla 07:47:33 INFO - mozversion application_version: 53.0a1 07:47:33 INFO - mozversion platform_buildid: 20161124062519 07:47:33 INFO - mozversion platform_changeset: 8332d69f0f65b0c2612338d86fc69d58ab70c318 07:47:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:47:33 INFO - mozversion platform_version: 53.0a1 07:47:33 INFO - using testdate: 1480002453 07:47:33 INFO - actual date: 1480002453 07:47:33 INFO - starting webserver on 'localhost:45879' 07:47:33 INFO - SUITE-START | Running 2 tests 07:47:33 INFO - TEST-START | dromaeo_css 07:47:33 INFO - operating with platform_type : linux_ 07:47:33 INFO - Initialising browser for dromaeo_css test... 07:47:33 INFO - TEST-INFO | started process 28397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV83qT4/profile http://localhost:45879/getInfo.html) 07:47:38 INFO - PROCESS | 28397 | __metrics Screen width/height:1600/1200 07:47:38 INFO - PROCESS | 28397 | colorDepth:24 07:47:38 INFO - PROCESS | 28397 | Browser inner width/height: 1024/697 07:47:38 INFO - PROCESS | 28397 | __metrics 07:47:38 INFO - PROCESS | 28397 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:47:38 INFO - PROCESS | 28397 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:47:40 INFO - TEST-INFO | 28397: exit 0 07:47:40 INFO - Browser initialized. 07:47:40 INFO - Running cycle 1/1 for dromaeo_css test... 07:47:40 INFO - TEST-INFO | started process 28478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV83qT4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:52 INFO - PROCESS | 28478 | RSS: Main: 174247936 07:47:52 INFO - PROCESS | 28478 | 07:48:43 INFO - PROCESS | 28478 | 1480002523663 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] 07:50:56 INFO - PROCESS | 28478 | Cycle 1(1): loaded http://localhost:45879/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45879/tests/dromaeo/cssquery-ext.html) 07:50:59 INFO - PROCESS | 28478 | RSS: Main: 411213824 07:50:59 INFO - PROCESS | 28478 | 07:54:02 INFO - PROCESS | 28478 | Cycle 1(1): loaded http://localhost:45879/tests/dromaeo/cssquery-ext.html (next: http://localhost:45879/tests/dromaeo/cssquery-jquery.html) 07:54:02 INFO - PROCESS | 28478 | RSS: Main: 279605248 07:54:02 INFO - PROCESS | 28478 | 07:57:05 INFO - PROCESS | 28478 | Cycle 1(1): loaded http://localhost:45879/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45879/tests/dromaeo/cssquery-mootools.html) 07:57:05 INFO - PROCESS | 28478 | RSS: Main: 222609408 07:57:05 INFO - PROCESS | 28478 | 08:00:08 INFO - PROCESS | 28478 | Cycle 1(1): loaded http://localhost:45879/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45879/tests/dromaeo/cssquery-prototype.html) 08:00:09 INFO - PROCESS | 28478 | RSS: Main: 220348416 08:00:09 INFO - PROCESS | 28478 | 08:03:12 INFO - PROCESS | 28478 | Cycle 1(1): loaded http://localhost:45879/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45879/tests/dromaeo/cssquery-yui.html) 08:03:12 INFO - PROCESS | 28478 | RSS: Main: 219664384 08:03:12 INFO - PROCESS | 28478 | 08:06:15 INFO - PROCESS | 28478 | Cycle 1(1): loaded http://localhost:45879/tests/dromaeo/cssquery-yui.html (next: http://localhost:45879/tests/dromaeo/cssquery-dojo.html) 08:06:16 INFO - PROCESS | 28478 | RSS: Main: 303968256 08:06:16 INFO - PROCESS | 28478 | 08:06:16 INFO - PROCESS | 28478 | __start_tp_report 08:06:16 INFO - PROCESS | 28478 | _x_x_mozilla_page_load 08:06:16 INFO - PROCESS | 28478 | _x_x_mozilla_page_load_details 08:06:16 INFO - PROCESS | 28478 | |i|pagename|runs| 08:06:16 INFO - PROCESS | 28478 | |0;dojo.html;2616.1628278950734;2648.615950687149;2681.6916054653707;2686.3821321096148;2686.570148776196;4541.977290113553;4608.5852273295395;4722.126406614774;4807.711537307764;4840.612750979917;4625.745583992879;4731.1956967315555;4749.8812529686775;4762.119007983517;4798.448178459478;4294.763787991659;4306.289462238727;4357.128574285156;4385.561443855605;4482.484514280851;4290.2706539888295;4382.298832186851;4400.295952647577;4430.26900561407;4476.48520420151;4239.0885959518855;4277.1873344064525;4400.317950717644;4464.6428285737065;4498.595126438619;4287.356896465524;4313.611774940239;4319.07139964909;4351.477822661301;4446.55534446556;4320.762358070305;4347.3696314034605;4349.238883195429;4356.934645980313;4401.119776044804;4703.50613185614;4717.268823332389;4736.431628204603;4741.668083234175;4747.098051370263;4899.461059283476;4948.1093403187415;4950.579200767939;5047.470015648378;5101.132807422747;5163.483651634844;5164.122099243138;5199.168133098686;5202.713850738246;5214.061468935628;4756.262779269219;4769.213079841857;4785.808567657289;4794.880127996758;4825.445073816486;4966.230234313687;5179.04187725272;5203.19350500673;5205.24523944026;5258.39528454225;4823.517648235219;4902;4903.901921961541;5011.649184557119;5018.974905125451;5015.874603134951;5017.799288028438;5026.246063090565;5029.748512574357;5082.440931497532;4943.184374578226;4957.950420495821;5000.724960127228;5045.217991211368;5057;4821;4874.073925954058;4877.365942427462;4906.386701662293;4966.751662416865;4363.2800587903275;4435.401220835146;4439.467263928284;4471.441069866267;4484.327350897392;3842.193139440749;3851.1912498375655;3851.8844434667003;3875.844966201377;3888.5528164260904;4207.663386929038;4265.850695225714;4418.5802348776815;4421.690481666253;4470.083632855257;5033.219850923113;5074.543291103744;5095.974520127375;5132.717700526507;5150.948490515047;4388;4391.7145385550475;4405.3612226227015;4405.537418571068;4432.3351497275025;4433.977830110829;4613.746243956614;4614.792334344963;4628.490866004737;4672.486026537078;4603.953960460352;4652.069586082865;4666.300054991779;4668.673192876466;4670.229412146958;4943.703377797344;5004;5015.924761128513;5017.397912250407;5017.62367822422;4656.41794775653;4668.603168730696;4670.813167473399;4672.065586882569;4673.929891051569;4919.409670839379;4921.9015619688125;4922.3600931880055;4923.163062279349;4923.852284431473;5023.723695196799;5031.069252188357;5066.569341606005;5066.569341606005;5072.239164125263;4933.038057578738;4935.383077115361;4939.678920870132;4941.382327209099;4945.604351651931;4859.781309840995;4859.829905953275;4866.075445665312;4916.041371932439;4974.527419895104;4850.296706977398;4861.538153875376;4869.342638743724;4876.90246195067;4935.925961110658;4832.975835120802;4876.097921884463;4894.412670479565;4926.3349447824085;4965.354503914468;4828.179209534317;4897.926531102107;4933.605311575137;4939.925901111558;4945.777440015136 08:06:16 INFO - PROCESS | 28478 | |1;ext.html;561.0154179415127;565.9122835960425;580.9041508151155;585.3911931591143;586.6538742142138;27062;29831.85084074582;29857.55213671794;29863.552046719316;37413.43879841798;37211.4418283726;37982.25221847269;37982.620173798256;37995.430068548994;38057.23885522288;7516.248375162468;7655.770326890202;7657.081150261976;7661.693532258703;7665.731699390522;7245.420366370704;7448.776536703907;7590.6963721451075;7678;7685.462017658766;7567.697292108309;7595.202503737111;7622.923770762277;9648.276379271547;9906.257030722689;9848.458334791583;9945.950270248675;9948.403095814201;9948.452835094067;9950.452725100153;9624.759381015461;9683.41899486033;9698.466584337859;9706.417614943055;9711.417314961054;36060.63939360599;36371.81814090939;36399;36420.27159456823;36442.088947776254;2799.8740056697497;2887.6823549409546;2897.3915477749697;2945.808522446034;3531.2231309111953;26680;26795.33011674704;26805.32986675329;26876.46247075067;27067.187984360502;3057.464943634855;3101.1006808025872;3124.98437507811;3147.5436061770915;3149.1812128846664;251431;252766.34887941147;253246;253781;254283;52646;53220.669483262456;53264;53287.46712532903;53364.46635533595;54686;54746;54757.45242547603;54808.72595637076;54814.72592637011;13879;14401.351939162763;14414.783778243334;14420.278986050656;14434.783478247835;11053.778924421627;11117.388543630179;11126.499307531181;11127.054200392895;11127.777444451065;16700.74131096587;17287.74068388975;17346.739798903025;17453.38913138034;17483.125843707763;5272.762725677354;6456.322086180978;6575.4410875076155;6853.931460685429;7119.394851437686;766.6435107674846;915.3409545127497;928.9767755806024;936.6581197862731;987.7382493639192;25714.35714107162;26750.5987410189;27077.458450830873;27177.592336114973;27286;918.6509126532009;924.0297687428174;955.2119501411363;990.1781521337273;1015.020913618532;14441;14501.419943202154;14623.976321657381;14709.190994495191;14851;342690;348813;349086;349934;350387;46779.15260592426;47587.286190707164;47621.28568071482;47643.76178119087;47653.5234647656;1103.475848971732;1135.795556799784;1140.9543618255343;1144.994275028603;1150.6950658075616;24610.630840537764;25922;26883.462330752885;26907.596386053832;26916.327091822863;40489.392659109544;40527.1894562113;40781.388279176426;40839.38740918948;40974.385384218665;291217;293600;294106;294454;294740.73629691434;23448.413789654714;24428.511429770948;24432.63351049771;24444.388890277885;24450.266492005267;39496;39601.40597890977;39648;40019.599804002755;40891.18217635571;33846.66153338435;33884;34003;34023.48964765481;34069.829650851585;33044.669553305124;33523.497147542315;33771.83114084512;34091.488627671104;34658;33438.331233375684;33541.83229083839;33585.16037099092;33759.4936075964;33785.15537111592;25712.61431078498;25962.22113336603;28788.280292992844;29314.7068529312;29711.40577188401;22567.529769040015;23448.531029378977;23470.530589388458;23543;23730.169444069375 08:06:16 INFO - PROCESS | 28478 | |2;jquery.html;332.29553346904567;352.34815591156365;361.3639993611244;370.75715406408796;379.59573054696745;11741.53033878645;12392.81410778838;12904.354782260896;13427.261500617462;16054.357825686988;15912;16125.193740312967;16126.75809862853;16234.350625974947;16245;4712.3638308828295;4946.554810067093;4995.175795993657;5252.6848389096585;5294.735263236842;5303.920441193385;5337.893242135155;5344.011357898782;5346.224797404374;5349.652272602269;3366.1584603849037;3451.3442445935316;3538.5046093546925;5354.196870469422;5355.518003379695;5422.53908417785;5427.972860135694;5428.131498960148;5431.348238211401;5433.7283135843445;4532.841350552748;4826.624412042551;4856.830010949635;4914.557689807934;4916.827911023132;11719.531218751239;11871.881281187163;11876.643700688994;11935.104867135;11958.804119588058;1774.1218097041917;1786.428342930263;1799.1004497751123;1828.579426731859;2134.4983928776724;8751;8955.910440895574;9697.515124243759;9904.108630223314;12969.221846689228;1552.6351307442856;1585.1994742654886;1658.461000174948;1670.5489517830117;1737.504811128835;64745;66627;68105.3189468104;68650;69525.95711064288;9582.472963987047;9639.90360096404;9764.229103032554;9953.104220620178;9971.501424928725;13387;13412.664683382993;13422;13423.798643020362;13452.663683407993;6622.801315960529;6698;6862.656867156622;6874.106366172366;7116.359527642537;6367;6384.138141350951;6428.296501427126;6484.286728459866;6703.229128650268;4218.346156345771;4241.936370954438;4244.660427165819;4267.1892340455215;4347.695661303678;1651.9091449970126;1804.49474147239;1828.3966291123897;1831.3407173417559;1841.9447416577525;747.4095464582919;758.6775620361435;800.931920786728;830.8795224692386;869.682565863468;15395.692086158215;15506.689866202838;16108.838911610734;16166.676666466605;16197.109158996369;795.2882170457524;852.8038551133274;858.4205661178679;859.3243175807077;880.5553195636163;8515.19105684959;9218.723438296862;9286.860697089549;9318.161365477139;9380.8592871107;350728;354423;356975;357083;357709;72464.63767681233;73189.26810731825;73464;75231;80272;880.5861245214738;897.6499165325529;898.0480690467995;906.6600024990629;908.2824568590871;14113.858861411254;14259.928700356431;14401.63995900111;14532.346044428237;14984.550463486114;35039.18948565022;35475;36309.45535816912;36415.08962275858;37161.628383716896;46170.76914615405;46381.304280436496;46615.57152070548;47168.764156179;49296;6934.826629334307;6936.79189624312;7466.701331946661;7473.290037446434;7492.363149132385;10379;10929.836052459379;11097.112231021338;11378.658640240807;11427.371494567878;9661.71014869555;9793.804123917624;10071.143952764098;10172.84740728875;10174.491275436347;9383.671571494964;9668.75828104303;9880.901190988287;10070.597176112873;10399.376037437778;9929.3545919515;9984.750381240527;10046.095851373411;10277.897221027693;10598.841017384591;7150.141982962078;7224.313690199423;7272.600006999666;7370.852582948204;7433.9256607433235;8408.369372297224;9813;9870.901290987285;9936.751581210528;10400.73998150022 08:06:16 INFO - PROCESS | 28478 | |3;mootools.html;1212.0667086343522;1300.9674758131048;1372.9931350343247;1421.6588018875466;1652.0665823809547;6146.293176284728;6763;6976.372126508613;6982.755603553876;7102.57384556927;6969.407600353976;7039.401650859683;7043.119610048744;7047.330503602149;7054.2240353561065;2089.9373018809424;2119.618468675638;2121.8302535797097;2121.957560848782;2124.097258665061;1835.5869929265941;1871.7660292463443;2030.6547886859269;2078.1687325069943;2093.5394213273057;2003.6794112941932;2009.969850452237;2010.7989201079922;2014.6575082235981;2016.4353980885376;2063.2778527515325;2078.376487053878;2109.947251318714;2119.6608542633257;2122.2572099764957;1802.8287312705272;1863.9347622833136;1866.5333666583354;1874.1378965675806;1878.0703551741838;6847.828804279883;6954.23503414624;6965.721371145148;7191.101112360955;7279.3084656958035;4122.464079669624;4212.831486740527;4246.63903568194;4248.235317642823;4249.32010878258;2758.917232483029;2833.3766571354267;2867.7562407195414;2887.2926133097317;2890.898818541341;896.2605850173633;902.4675441489487;927.2072378116748;942.2320808541017;946.7443790176613;9209.125133112344;9261.21279691227;9286.953565232197;9347.626094956193;9560.187384072362;3676.5955744868043;3725.2549490102087;3748.3253014457114;3762.62373762627;3808.7524310919703;7399.186089530147;7406.259374062551;7407.2592740725495;7411.629418529052;7412.221716719775;4284.592963668447;4286.957130428656;4291.6566674665955;4294.119705460374;4296.3555466680245;3829.272438236726;3849.615038496128;3968.7420317679835;4041.9797901010306;4044.5753195914594;2904.6514418269944;2913.222934010252;3004;3015.532592448174;3038.14931819091;926.6015613286216;947.7488465556632;950.6245033211843;956.0439560439561;961.2262128986093;719.6725489902082;806.4193780478047;831.6673330667782;843.0178841649532;846.3821361025945;4685;4763.261694437368;4764.356811830427;4830.637702172281;4844.079624871263;404.85425246911086;410.30453381518635;413.1818998383158;415.89810496428566;421.0673358510913;3403.9659603404143;3404.2000129969438;3450.5859296884532;3452.1197094740683;3557.768745031565;7456.7390141344795;7768.65041073153;8033.1163572007035;8448.11294814048;8548.957255213683;8674.436161649473;8674.739757807276;8675.089115642766;8675.479471231747;8678.696245631372;6272.6236425814595;6406.359364063556;6420.550561460653;6431.006388019729;6465.15952926126;4907.116718990616;4945.406551213878;5020.146575082172;5134.743262836769;5161.354830646169;7650.655720492702;7729.304362607392;7836.960815195887;7842.725504607311;7920.564368959763;7802.375809935305;8042.276195142465;8134.83730325402;8203.261706446448;8203.753887383387;6044.425779550936;6210.503159747119;6215.65813880241;6221.813345599639;6224.221972253468;6380.87238255223;6608.173978252718;6727.798166055026;6787.253402125663;6789.728410863708;6171.660558669317;6211.3478084800445;6256.812295631138;6322.525810564134;6372.9362706374195;6025.457708806229;6072.696365181811;6090.69546522681;6093.725782339894;6117.195427349032;5576.804811831566;5586.86032849182;5623.1846382273525;5686.744096515749;5759.395263497272;4217.093324935154;4304.246756817607;4335.501417336921;4431.4682238130345;4464.732116073046;4374.540673229265;4391.64866810648;4437.489688685713;4493.0789188216995;4561.475430325422 08:06:16 INFO - PROCESS | 28478 | |4;prototype.html;277.3357808049721;281.62403191739025;289.2869077723411;290.91418031680666;291.27472593242834;4810.701110700109;4865.883340746773;4894.461609222992;4898.583620392266;4930.45764965854;4705.176594096037;4721.504242054586;4797.304390863323;4807.423109226889;4819.469858315582;3502.7723197992113;3585.6414358564066;3636.6181550937167;3653.3971894637352;3734;3708.7589306694977;3717.6282371762877;3722.4044152935535;3729.254149170163;3735.8318875650525;3661;3671.4492826076034;3682.1162920898923;3684.44733290006;3699.981500092496;3465.8267086645565;3578.9642103579154;3588.3182195382924;3707.8146092695256;3717.4052151655605;3257.1368587324378;3268.248302890325;3270.3295824356187;3270.460374038281;3273.116258610186;4610.700304480198;4622.768861556909;4623.768811559442;4641.791119399635;4649.071085216292;4067.491563554556;4231.407602935591;4235.618794308527;4236.766977816219;4241.936370954438;4979.584901322855;4986.40163180417;4988.476209997971;4990;4998.9500104999215;3583.7491375603718;3591.3894637911617;3592.2456284180353;3599.6220396858216;3604.7296452765886;5137.101007323703;5235.240890070956;5247.606429517801;5249.370075590953;5286.127788914863;3630.8729194478597;3654.9634503655157;3656.780593164419;3668.3947148720695;3669.522962014921;3701.2597480504005;3710.9814450927574;3718;3721.7953012584567;3723.236736469017;4213.199492096492;4216.409702641633;4222.303319952173;4223.128272774481;4229.281022226229;4813.3983252093485;4926;4969.378827646544;4983.775730092155;5036.665283699749;1225.2403509823966;1226.7117227451542;1226.7362517058875;1231.7228623559806;1236.9876301236873;795.9562224077731;822.6837060702948;857.7341024282367;867.5965675960582;871.6034204436966;4198.1393814268;4297.39836422901;4474.239379305526;4481.193385190697;4492.8094055075435;5171.500264923206;5171.612129090333;5173.586113110942;5176.327077479904;5176.861090560071;4466.798994045275;4483.50681425043;4490.977545112253;4498.167838949805;4508.661850361236;2532.670752802124;2635.881385337626;2652.6949400819153;2654.6947101083238;2658.3354161459633;4655.348251244828;4660.743659098782;4677.146940366374;4678.906421871544;4697.177993851063;4849.817582088074;5142.61430392722;5144.6655967362;5156.813932795478;5165.856169689612;4661.813527458864;4686.617447852892;4735.786889590046;4737.336772851803;4738.455077666113;5007.649464537593;5008.248762685626;5027.74861256943;5030.496950304941;5052.8484145475695;4653.255479123324;4870.853874383774;4875.512448755097;4926.359573255454;4936.777844997056;4646.953530464652;4677.269410318204;4688.695234809727;4694.812207511662;4707.223308154116;3465.514827924143;3467.271872906617;3470.5314782505047;3501.5272938154044;3508.5965114012215;5061.266116413173;5066.164082926276;5071.112555302881;5074.923876141935;5088.211327244283;4709.5055019223855;4868.391451068616;4875.90248195027;4876.512348765095;4881.560659540658;4845.8061677533915;4871.707697538159;4873.245631572702;4878.121938051185;4891.119598472309;4692.859214223578;4720.575148236675;4724.149653062482;4748.762561871962;4758.000819827875;4720.433547974265;4884.340614017062;5062.140345268584;5068.467810879804;5097;4933.284673722218;4938.333325001223;4938.950610493849;4944.3572335596145;4948.505149485023 08:06:16 INFO - PROCESS | 28478 | |5;yui.html;617.4473845907912;620.7516993202721;633.8193614819775;694.4617921111138;709.1206903439736;11881.52473901044;12981.091323607352;13005.284709340982;13008;13013.414396352151;12123;12335.383230838444;12368.381580920963;12382.31897245651;12402.193857399285;613.4816080412045;626.9153664255335;736.3887972982425;736.8526294741073;741.7070257248383;769.3768047881206;772.5326177662517;772.7565816767728;773.1456740301969;773.1997382708897;815.339574944297;815.4617952151581;816.147126253064;816.1634324817051;816.7876352148425;645.7094307561592;664.9368310010566;768.9115751688571;790.9248621380959;797.1908512859452;588.8881112588638;589.3163929841363;590.6485641043615;590.8759160576284;591.0808692483187;12185.939070304592;12206.938965305206;12223.14437989341;12230.205036672676;12238.938805306005;11976.940115299367;11980.760384792255;12010.939945300304;12081.87918120825;12408.62774116778;9377.249820014382;9443;9561.378510396871;9599.616015359377;9694.709158725249;3898.5321761388814;3920.627540383659;3954.920901581981;3985.601439855991;4034.959650403517;45335.77332113318;46081.30878036832;46195.997260178316;46347.768261158475;46941.29588056182;9443.858342124873;9484.905150948402;9571.712848614552;9688;10075.34510256831;17212.655746884993;17249.655006899793;17255.91372043157;17387.565310867078;17390.913045434692;6332.398422149889;6347.39699728525;6361.872762544724;6370.203724534434;6374.171357723466;3435.2270739084006;3554.0759402555523;3694.5012423323046;3704.148045949447;3713.517242758424;2492.1651246832516;2580.1614475295605;2585.7414258574368;2586.728393518691;2589.3397183718407;391.81193027347035;452.63336697275315;455.65142665860645;464.8721601559598;470.1185277604492;442.35416292213085;470.7999100382392;479.6234955559869;594.5481434110108;603.4659326496082;7614.162442131361;7853;8099.392545559107;8142.557232830127;8201.79495512605;562.4066609726777;571.6128712134353;573.0258560447256;573.3807487913044;584.9327327357408;3806;3969.2458432897656;3977.721559490808;3999.7000224983244;4091.447654566655;41407.585924140374;51300.48699512957;53276.200856987176;53606.731966340696;61017.69491152604;53055.469445305054;54291.75644800819;54918.72540637351;54946;55094;49396.259056114184;49497;49755.25367119424;50377.74811125994;52403.47596523986;8195.385346098947;8320.167983201873;8513.787155320919;8645.308375330083;8769.91230087691;35188;35674.46488302626;35847.46228806518;36129.27741445209;36233.63766362303;46737;47396.7630161847;48134.759326203144;48488.757556212;50541.74729126478;8717;9096.363254572116;9102.180803727697;10027.799444011225;10116.59533618647;11474.483648236017;11569.074474042225;11859.52561897549;12070.27578345302;12486.625401237978;11009.339439633648;11108.333499990027;11133;11219.326840389604;11244.156688248251;11195.263081692921;11599.536018559163;11922;11966.401679916144;12309.13836031505;11405.828912566152;11470.770584588428;11534;11744.236624619372;12340.259584424963;9234.538273086184;9297.911765733983;9758.414495130315;10147.441890695787;10157.593696252066;8888.644454222018;9298.814023719622;9767.267454940766;9847.212223021997;9880.950595246977 08:06:16 INFO - PROCESS | 28478 | __end_tp_report 08:06:16 INFO - PROCESS | 28478 | __start_cc_report 08:06:16 INFO - PROCESS | 28478 | _x_x_mozilla_cycle_collect,2722 08:06:16 INFO - PROCESS | 28478 | __end_cc_report 08:06:16 INFO - PROCESS | 28478 | __startTimestamp1480003576071__endTimestamp 08:06:16 INFO - PROCESS | 28478 | 08:06:16 INFO - PROCESS | 28478 | ------- Summary: start ------- 08:06:16 INFO - PROCESS | 28478 | Number of tests: 6 08:06:16 INFO - PROCESS | 28478 | 08:06:16 INFO - PROCESS | 28478 | [#0] dojo.html Cycles:165 Average:4673.26 Median:4807.71 stddev:469.64 (9.8%) stddev-sans-first:442.49 08:06:16 INFO - PROCESS | 28478 | Values: 2616.2 2648.6 2681.7 2686.4 2686.6 4542.0 4608.6 4722.1 4807.7 4840.6 4625.7 4731.2 4749.9 4762.1 4798.4 4294.8 4306.3 4357.1 4385.6 4482.5 4290.3 4382.3 4400.3 4430.3 4476.5 4239.1 4277.2 4400.3 4464.6 4498.6 4287.4 4313.6 4319.1 4351.5 4446.6 4320.8 4347.4 4349.2 4356.9 4401.1 4703.5 4717.3 4736.4 4741.7 4747.1 4899.5 4948.1 4950.6 5047.5 5101.1 5163.5 5164.1 5199.2 5202.7 5214.1 4756.3 4769.2 4785.8 4794.9 4825.4 4966.2 5179.0 5203.2 5205.2 5258.4 4823.5 4902.0 4903.9 5011.6 5019.0 5015.9 5017.8 5026.2 5029.7 5082.4 4943.2 4958.0 5000.7 5045.2 5057.0 4821.0 4874.1 4877.4 4906.4 4966.8 4363.3 4435.4 4439.5 4471.4 4484.3 3842.2 3851.2 3851.9 3875.8 3888.6 4207.7 4265.9 4418.6 4421.7 4470.1 5033.2 5074.5 5096.0 5132.7 5150.9 4388.0 4391.7 4405.4 4405.5 4432.3 4434.0 4613.7 4614.8 4628.5 4672.5 4604.0 4652.1 4666.3 4668.7 4670.2 4943.7 5004.0 5015.9 5017.4 5017.6 4656.4 4668.6 4670.8 4672.1 4673.9 4919.4 4921.9 4922.4 4923.2 4923.9 5023.7 5031.1 5066.6 5066.6 5072.2 4933.0 4935.4 4939.7 4941.4 4945.6 4859.8 4859.8 4866.1 4916.0 4974.5 4850.3 4861.5 4869.3 4876.9 4935.9 4833.0 4876.1 4894.4 4926.3 4965.4 4828.2 4897.9 4933.6 4939.9 4945.8 08:06:16 INFO - PROCESS | 28478 | 08:06:16 INFO - PROCESS | 28478 | [#1] ext.html Cycles:180 Average:44706.18 Median:34046.66 stddev:78988.94 (232.0%) stddev-sans-first:79140.98 08:06:16 INFO - PROCESS | 28478 | Values: 561.0 565.9 580.9 585.4 586.7 27062.0 29831.9 29857.6 29863.6 37413.4 37211.4 37982.3 37982.6 37995.4 38057.2 7516.2 7655.8 7657.1 7661.7 7665.7 7245.4 7448.8 7590.7 7678.0 7685.5 7567.7 7595.2 7622.9 9648.3 9906.3 9848.5 9946.0 9948.4 9948.5 9950.5 9624.8 9683.4 9698.5 9706.4 9711.4 36060.6 36371.8 36399.0 36420.3 36442.1 2799.9 2887.7 2897.4 2945.8 3531.2 26680.0 26795.3 26805.3 26876.5 27067.2 3057.5 3101.1 3125.0 3147.5 3149.2 251431.0 252766.3 253246.0 253781.0 254283.0 52646.0 53220.7 53264.0 53287.5 53364.5 54686.0 54746.0 54757.5 54808.7 54814.7 13879.0 14401.4 14414.8 14420.3 14434.8 11053.8 11117.4 11126.5 11127.1 11127.8 16700.7 17287.7 17346.7 17453.4 17483.1 5272.8 6456.3 6575.4 6853.9 7119.4 766.6 915.3 929.0 936.7 987.7 25714.4 26750.6 27077.5 27177.6 27286.0 918.7 924.0 955.2 990.2 1015.0 14441.0 14501.4 14624.0 14709.2 14851.0 342690.0 348813.0 349086.0 349934.0 350387.0 46779.2 47587.3 47621.3 47643.8 47653.5 1103.5 1135.8 1141.0 1145.0 1150.7 24610.6 25922.0 26883.5 26907.6 26916.3 40489.4 40527.2 40781.4 40839.4 40974.4 291217.0 293600.0 294106.0 294454.0 294740.7 23448.4 24428.5 24432.6 24444.4 24450.3 39496.0 39601.4 39648.0 40019.6 40891.2 33846.7 33884.0 34003.0 34023.5 34069.8 33044.7 33523.5 33771.8 34091.5 34658.0 33438.3 33541.8 33585.2 33759.5 33785.2 25712.6 25962.2 28788.3 29314.7 29711.4 22567.5 23448.5 23470.5 23543.0 23730.2 08:06:16 INFO - PROCESS | 28478 | 08:06:16 INFO - PROCESS | 28478 | [#2] jquery.html Cycles:180 Average:22527.58 Median:4885.69 stddev:58880.41 (1205.2%) stddev-sans-first:59022.00 08:06:16 INFO - PROCESS | 28478 | Values: 332.3 352.3 361.4 370.8 379.6 11741.5 12392.8 12904.4 13427.3 16054.4 15912.0 16125.2 16126.8 16234.4 16245.0 4712.4 4946.6 4995.2 5252.7 5294.7 5303.9 5337.9 5344.0 5346.2 5349.7 3366.2 3451.3 3538.5 5354.2 5355.5 5422.5 5428.0 5428.1 5431.3 5433.7 4532.8 4826.6 4856.8 4914.6 4916.8 11719.5 11871.9 11876.6 11935.1 11958.8 1774.1 1786.4 1799.1 1828.6 2134.5 8751.0 8955.9 9697.5 9904.1 12969.2 1552.6 1585.2 1658.5 1670.5 1737.5 64745.0 66627.0 68105.3 68650.0 69526.0 9582.5 9639.9 9764.2 9953.1 9971.5 13387.0 13412.7 13422.0 13423.8 13452.7 6622.8 6698.0 6862.7 6874.1 7116.4 6367.0 6384.1 6428.3 6484.3 6703.2 4218.3 4241.9 4244.7 4267.2 4347.7 1651.9 1804.5 1828.4 1831.3 1841.9 747.4 758.7 800.9 830.9 869.7 15395.7 15506.7 16108.8 16166.7 16197.1 795.3 852.8 858.4 859.3 880.6 8515.2 9218.7 9286.9 9318.2 9380.9 350728.0 354423.0 356975.0 357083.0 357709.0 72464.6 73189.3 73464.0 75231.0 80272.0 880.6 897.6 898.0 906.7 908.3 14113.9 14259.9 14401.6 14532.3 14984.6 35039.2 35475.0 36309.5 36415.1 37161.6 46170.8 46381.3 46615.6 47168.8 49296.0 6934.8 6936.8 7466.7 7473.3 7492.4 10379.0 10929.8 11097.1 11378.7 11427.4 9661.7 9793.8 10071.1 10172.8 10174.5 9383.7 9668.8 9880.9 10070.6 10399.4 9929.4 9984.8 10046.1 10277.9 10598.8 7150.1 7224.3 7272.6 7370.9 7433.9 8408.4 9813.0 9870.9 9936.8 10400.7 08:06:16 INFO - PROCESS | 28478 | 08:06:16 INFO - PROCESS | 28478 | [#3] mootools.html Cycles:180 Average:4613.49 Median:5581.83 stddev:2510.51 (45.0%) stddev-sans-first:2504.54 08:06:16 INFO - PROCESS | 28478 | Values: 1212.1 1301.0 1373.0 1421.7 1652.1 6146.3 6763.0 6976.4 6982.8 7102.6 6969.4 7039.4 7043.1 7047.3 7054.2 2089.9 2119.6 2121.8 2122.0 2124.1 1835.6 1871.8 2030.7 2078.2 2093.5 2003.7 2010.0 2010.8 2014.7 2016.4 2063.3 2078.4 2109.9 2119.7 2122.3 1802.8 1863.9 1866.5 1874.1 1878.1 6847.8 6954.2 6965.7 7191.1 7279.3 4122.5 4212.8 4246.6 4248.2 4249.3 2758.9 2833.4 2867.8 2887.3 2890.9 896.3 902.5 927.2 942.2 946.7 9209.1 9261.2 9287.0 9347.6 9560.2 3676.6 3725.3 3748.3 3762.6 3808.8 7399.2 7406.3 7407.3 7411.6 7412.2 4284.6 4287.0 4291.7 4294.1 4296.4 3829.3 3849.6 3968.7 4042.0 4044.6 2904.7 2913.2 3004.0 3015.5 3038.1 926.6 947.7 950.6 956.0 961.2 719.7 806.4 831.7 843.0 846.4 4685.0 4763.3 4764.4 4830.6 4844.1 404.9 410.3 413.2 415.9 421.1 3404.0 3404.2 3450.6 3452.1 3557.8 7456.7 7768.7 8033.1 8448.1 8549.0 8674.4 8674.7 8675.1 8675.5 8678.7 6272.6 6406.4 6420.6 6431.0 6465.2 4907.1 4945.4 5020.1 5134.7 5161.4 7650.7 7729.3 7837.0 7842.7 7920.6 7802.4 8042.3 8134.8 8203.3 8203.8 6044.4 6210.5 6215.7 6221.8 6224.2 6380.9 6608.2 6727.8 6787.3 6789.7 6171.7 6211.3 6256.8 6322.5 6372.9 6025.5 6072.7 6090.7 6093.7 6117.2 5576.8 5586.9 5623.2 5686.7 5759.4 4217.1 4304.2 4335.5 4431.5 4464.7 4374.5 4391.6 4437.5 4493.1 4561.5 08:06:16 INFO - PROCESS | 28478 | 08:06:16 INFO - PROCESS | 28478 | [#4] prototype.html Cycles:180 Average:4103.36 Median:4677.21 stddev:1194.24 (25.5%) stddev-sans-first:1162.55 08:06:16 INFO - PROCESS | 28478 | Values: 277.3 281.6 289.3 290.9 291.3 4810.7 4865.9 4894.5 4898.6 4930.5 4705.2 4721.5 4797.3 4807.4 4819.5 3502.8 3585.6 3636.6 3653.4 3734.0 3708.8 3717.6 3722.4 3729.3 3735.8 3661.0 3671.4 3682.1 3684.4 3700.0 3465.8 3579.0 3588.3 3707.8 3717.4 3257.1 3268.2 3270.3 3270.5 3273.1 4610.7 4622.8 4623.8 4641.8 4649.1 4067.5 4231.4 4235.6 4236.8 4241.9 4979.6 4986.4 4988.5 4990.0 4999.0 3583.7 3591.4 3592.2 3599.6 3604.7 5137.1 5235.2 5247.6 5249.4 5286.1 3630.9 3655.0 3656.8 3668.4 3669.5 3701.3 3711.0 3718.0 3721.8 3723.2 4213.2 4216.4 4222.3 4223.1 4229.3 4813.4 4926.0 4969.4 4983.8 5036.7 1225.2 1226.7 1226.7 1231.7 1237.0 796.0 822.7 857.7 867.6 871.6 4198.1 4297.4 4474.2 4481.2 4492.8 5171.5 5171.6 5173.6 5176.3 5176.9 4466.8 4483.5 4491.0 4498.2 4508.7 2532.7 2635.9 2652.7 2654.7 2658.3 4655.3 4660.7 4677.1 4678.9 4697.2 4849.8 5142.6 5144.7 5156.8 5165.9 4661.8 4686.6 4735.8 4737.3 4738.5 5007.6 5008.2 5027.7 5030.5 5052.8 4653.3 4870.9 4875.5 4926.4 4936.8 4647.0 4677.3 4688.7 4694.8 4707.2 3465.5 3467.3 3470.5 3501.5 3508.6 5061.3 5066.2 5071.1 5074.9 5088.2 4709.5 4868.4 4875.9 4876.5 4881.6 4845.8 4871.7 4873.2 4878.1 4891.1 4692.9 4720.6 4724.1 4748.8 4758.0 4720.4 4884.3 5062.1 5068.5 5097.0 4933.3 4938.3 4939.0 4944.4 4948.5 08:06:16 INFO - PROCESS | 28478 | 08:06:16 INFO - PROCESS | 28478 | [#5] yui.html Cycles:180 Average:13637.76 Median:24307.19 stddev:16243.45 (66.8%) stddev-sans-first:16259.59 08:06:16 INFO - PROCESS | 28478 | Values: 617.4 620.8 633.8 694.5 709.1 11881.5 12981.1 13005.3 13008.0 13013.4 12123.0 12335.4 12368.4 12382.3 12402.2 613.5 626.9 736.4 736.9 741.7 769.4 772.5 772.8 773.1 773.2 815.3 815.5 816.1 816.2 816.8 645.7 664.9 768.9 790.9 797.2 588.9 589.3 590.6 590.9 591.1 12185.9 12206.9 12223.1 12230.2 12238.9 11976.9 11980.8 12010.9 12081.9 12408.6 9377.2 9443.0 9561.4 9599.6 9694.7 3898.5 3920.6 3954.9 3985.6 4035.0 45335.8 46081.3 46196.0 46347.8 46941.3 9443.9 9484.9 9571.7 9688.0 10075.3 17212.7 17249.7 17255.9 17387.6 17390.9 6332.4 6347.4 6361.9 6370.2 6374.2 3435.2 3554.1 3694.5 3704.1 3713.5 2492.2 2580.2 2585.7 2586.7 2589.3 391.8 452.6 455.7 464.9 470.1 442.4 470.8 479.6 594.5 603.5 7614.2 7853.0 8099.4 8142.6 8201.8 562.4 571.6 573.0 573.4 584.9 3806.0 3969.2 3977.7 3999.7 4091.4 41407.6 51300.5 53276.2 53606.7 61017.7 53055.5 54291.8 54918.7 54946.0 55094.0 49396.3 49497.0 49755.3 50377.7 52403.5 8195.4 8320.2 8513.8 8645.3 8769.9 35188.0 35674.5 35847.5 36129.3 36233.6 46737.0 47396.8 48134.8 48488.8 50541.7 8717.0 9096.4 9102.2 10027.8 10116.6 11474.5 11569.1 11859.5 12070.3 12486.6 11009.3 11108.3 11133.0 11219.3 11244.2 11195.3 11599.5 11922.0 11966.4 12309.1 11405.8 11470.8 11534.0 11744.2 12340.3 9234.5 9297.9 9758.4 10147.4 10157.6 8888.6 9298.8 9767.3 9847.2 9881.0 08:06:16 INFO - PROCESS | 28478 | -------- Summary: end -------- 08:06:16 INFO - PROCESS | 28478 | 08:06:17 INFO - TEST-INFO | 28478: exit 0 08:06:17 INFO - TEST-OK | dromaeo_css | took 1123469ms 08:06:17 INFO - TEST-START | kraken 08:06:17 INFO - operating with platform_type : linux_ 08:06:17 INFO - Initialising browser for kraken test... 08:06:17 INFO - TEST-INFO | started process 28783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQrICyu/profile http://localhost:45879/getInfo.html) 08:06:21 INFO - PROCESS | 28783 | __metrics Screen width/height:1600/1200 08:06:21 INFO - PROCESS | 28783 | colorDepth:24 08:06:21 INFO - PROCESS | 28783 | Browser inner width/height: 1024/697 08:06:21 INFO - PROCESS | 28783 | __metrics 08:06:22 INFO - PROCESS | 28783 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:06:22 INFO - PROCESS | 28783 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:06:22 INFO - PROCESS | 28783 | console.error: PushService: 08:06:22 INFO - PROCESS | 28783 | stateChangeProcessEnqueue: Error transitioning state 08:06:22 INFO - PROCESS | 28783 | UnknownError 08:06:23 INFO - TEST-INFO | 28783: exit 0 08:06:23 INFO - Browser initialized. 08:06:23 INFO - Running cycle 1/1 for kraken test... 08:06:23 INFO - TEST-INFO | started process 28869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQrICyu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:35 INFO - PROCESS | 28869 | RSS: Main: 174452736 08:06:35 INFO - PROCESS | 28869 | 08:06:38 INFO - PROCESS | 28869 | Cycle 1(1): loaded http://localhost:45879/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45879/tests/kraken/driver.html?testName=audio-beat-detection) 08:06:39 INFO - PROCESS | 28869 | RSS: Main: 239681536 08:06:39 INFO - PROCESS | 28869 | 08:06:42 INFO - PROCESS | 28869 | Cycle 1(1): loaded http://localhost:45879/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45879/tests/kraken/driver.html?testName=audio-dft) 08:06:43 INFO - PROCESS | 28869 | RSS: Main: 218427392 08:06:43 INFO - PROCESS | 28869 | 08:06:46 INFO - PROCESS | 28869 | Cycle 1(1): loaded http://localhost:45879/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45879/tests/kraken/driver.html?testName=audio-fft) 08:06:46 INFO - PROCESS | 28869 | RSS: Main: 300351488 08:06:46 INFO - PROCESS | 28869 | 08:06:48 INFO - PROCESS | 28869 | Cycle 1(1): loaded http://localhost:45879/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45879/tests/kraken/driver.html?testName=audio-oscillator) 08:06:49 INFO - PROCESS | 28869 | RSS: Main: 210341888 08:06:49 INFO - PROCESS | 28869 | 08:06:51 INFO - PROCESS | 28869 | Cycle 1(1): loaded http://localhost:45879/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45879/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:06:52 INFO - PROCESS | 28869 | RSS: Main: 214327296 08:06:52 INFO - PROCESS | 28869 | 08:06:55 INFO - PROCESS | 28869 | Cycle 1(1): loaded http://localhost:45879/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45879/tests/kraken/driver.html?testName=imaging-darkroom) 08:06:56 INFO - PROCESS | 28869 | RSS: Main: 253833216 08:06:56 INFO - PROCESS | 28869 | 08:06:59 INFO - PROCESS | 28869 | Cycle 1(1): loaded http://localhost:45879/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45879/tests/kraken/driver.html?testName=imaging-desaturate) 08:07:00 INFO - PROCESS | 28869 | RSS: Main: 247812096 08:07:00 INFO - PROCESS | 28869 | 08:07:03 INFO - PROCESS | 28869 | Cycle 1(1): loaded http://localhost:45879/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45879/tests/kraken/driver.html?testName=json-parse-financial) 08:07:03 INFO - PROCESS | 28869 | RSS: Main: 249946112 08:07:03 INFO - PROCESS | 28869 | 08:07:05 INFO - PROCESS | 28869 | Cycle 1(1): loaded http://localhost:45879/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45879/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:07:06 INFO - PROCESS | 28869 | RSS: Main: 213065728 08:07:06 INFO - PROCESS | 28869 | 08:07:08 INFO - PROCESS | 28869 | Cycle 1(1): loaded http://localhost:45879/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45879/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:07:08 INFO - PROCESS | 28869 | RSS: Main: 220975104 08:07:08 INFO - PROCESS | 28869 | 08:07:10 INFO - PROCESS | 28869 | Cycle 1(1): loaded http://localhost:45879/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45879/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:07:11 INFO - PROCESS | 28869 | RSS: Main: 228716544 08:07:11 INFO - PROCESS | 28869 | 08:07:14 INFO - PROCESS | 28869 | Cycle 1(1): loaded http://localhost:45879/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45879/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:07:15 INFO - PROCESS | 28869 | RSS: Main: 233213952 08:07:15 INFO - PROCESS | 28869 | 08:07:18 INFO - PROCESS | 28869 | Cycle 1(1): loaded http://localhost:45879/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45879/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:07:18 INFO - PROCESS | 28869 | RSS: Main: 235487232 08:07:18 INFO - PROCESS | 28869 | 08:07:20 INFO - PROCESS | 28869 | Cycle 1(1): loaded http://localhost:45879/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45879/tests/kraken/driver.html?testName=ai-astar) 08:07:20 INFO - PROCESS | 28869 | RSS: Main: 286171136 08:07:20 INFO - PROCESS | 28869 | 08:07:20 INFO - PROCESS | 28869 | __start_tp_report 08:07:20 INFO - PROCESS | 28869 | _x_x_mozilla_page_load 08:07:20 INFO - PROCESS | 28869 | _x_x_mozilla_page_load_details 08:07:20 INFO - PROCESS | 28869 | |i|pagename|runs| 08:07:20 INFO - PROCESS | 28869 | |0;ai-astar;112;114;114;115;113;113;115;116;114;114 08:07:20 INFO - PROCESS | 28869 | |1;audio-beat-detection;163;132;128;165;136;136;128;128;164;130 08:07:20 INFO - PROCESS | 28869 | |2;audio-dft;166;163;161;162;163;166;162;161;161;160 08:07:20 INFO - PROCESS | 28869 | |3;audio-fft;76;75;76;108;77;77;77;76;92;76 08:07:20 INFO - PROCESS | 28869 | |4;audio-oscillator;83;82;108;83;84;83;97;82;82;107 08:07:20 INFO - PROCESS | 28869 | |5;imaging-gaussian-blur;117;118;117;117;117;117;118;117;117;117 08:07:20 INFO - PROCESS | 28869 | |6;imaging-darkroom;146;147;146;146;146;146;146;147;147;147 08:07:20 INFO - PROCESS | 28869 | |7;imaging-desaturate;95;95;95;95;95;95;97;96;95;95 08:07:20 INFO - PROCESS | 28869 | |8;json-parse-financial;63;62;63;62;73;64;65;64;64;65 08:07:20 INFO - PROCESS | 28869 | |9;json-stringify-tinderbox;67;67;67;68;67;66;69;67;67;70 08:07:20 INFO - PROCESS | 28869 | |10;stanford-crypto-aes;85;86;86;85;86;86;86;85;85;86 08:07:20 INFO - PROCESS | 28869 | |11;stanford-crypto-ccm;151;145;144;153;149;143;161;141;217;152 08:07:20 INFO - PROCESS | 28869 | |12;stanford-crypto-pbkdf2;181;179;193;177;180;178;176;180;185;182 08:07:20 INFO - PROCESS | 28869 | |13;stanford-crypto-sha256-iterative;72;70;71;69;70;68;68;72;80;72 08:07:20 INFO - PROCESS | 28869 | __end_tp_report 08:07:20 INFO - PROCESS | 28869 | __start_cc_report 08:07:20 INFO - PROCESS | 28869 | _x_x_mozilla_cycle_collect,1946 08:07:20 INFO - PROCESS | 28869 | __end_cc_report 08:07:20 INFO - PROCESS | 28869 | __startTimestamp1480003640912__endTimestamp 08:07:20 INFO - PROCESS | 28869 | 08:07:20 INFO - PROCESS | 28869 | ------- Summary: start ------- 08:07:20 INFO - PROCESS | 28869 | Number of tests: 14 08:07:20 INFO - PROCESS | 28869 | 08:07:20 INFO - PROCESS | 28869 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:1.15 (1.0%) stddev-sans-first:0.97 08:07:20 INFO - PROCESS | 28869 | Values: 112.0 114.0 114.0 115.0 113.0 113.0 115.0 116.0 114.0 114.0 08:07:20 INFO - PROCESS | 28869 | 08:07:20 INFO - PROCESS | 28869 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:136.00 stddev:16.15 (11.9%) stddev-sans-first:15.04 08:07:20 INFO - PROCESS | 28869 | Values: 163.0 132.0 128.0 165.0 136.0 136.0 128.0 128.0 164.0 130.0 08:07:20 INFO - PROCESS | 28869 | 08:07:20 INFO - PROCESS | 28869 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:2.07 (1.3%) stddev-sans-first:1.76 08:07:20 INFO - PROCESS | 28869 | Values: 166.0 163.0 161.0 162.0 163.0 166.0 162.0 161.0 161.0 160.0 08:07:20 INFO - PROCESS | 28869 | 08:07:20 INFO - PROCESS | 28869 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.50 stddev:10.72 (14.0%) stddev-sans-first:11.22 08:07:20 INFO - PROCESS | 28869 | Values: 76.0 75.0 76.0 108.0 77.0 77.0 77.0 76.0 92.0 76.0 08:07:20 INFO - PROCESS | 28869 | 08:07:20 INFO - PROCESS | 28869 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:83.00 stddev:10.69 (12.9%) stddev-sans-first:11.11 08:07:20 INFO - PROCESS | 28869 | Values: 83.0 82.0 108.0 83.0 84.0 83.0 97.0 82.0 82.0 107.0 08:07:20 INFO - PROCESS | 28869 | 08:07:20 INFO - PROCESS | 28869 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:07:20 INFO - PROCESS | 28869 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 08:07:20 INFO - PROCESS | 28869 | 08:07:20 INFO - PROCESS | 28869 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:07:20 INFO - PROCESS | 28869 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 08:07:20 INFO - PROCESS | 28869 | 08:07:20 INFO - PROCESS | 28869 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 08:07:20 INFO - PROCESS | 28869 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 97.0 96.0 95.0 95.0 08:07:20 INFO - PROCESS | 28869 | 08:07:20 INFO - PROCESS | 28869 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.00 stddev:3.17 (5.0%) stddev-sans-first:3.32 08:07:20 INFO - PROCESS | 28869 | Values: 63.0 62.0 63.0 62.0 73.0 64.0 65.0 64.0 64.0 65.0 08:07:20 INFO - PROCESS | 28869 | 08:07:20 INFO - PROCESS | 28869 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.00 stddev:1.18 (1.8%) stddev-sans-first:1.24 08:07:20 INFO - PROCESS | 28869 | Values: 67.0 67.0 67.0 68.0 67.0 66.0 69.0 67.0 67.0 70.0 08:07:20 INFO - PROCESS | 28869 | 08:07:20 INFO - PROCESS | 28869 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 08:07:20 INFO - PROCESS | 28869 | Values: 85.0 86.0 86.0 85.0 86.0 86.0 86.0 85.0 85.0 86.0 08:07:20 INFO - PROCESS | 28869 | 08:07:20 INFO - PROCESS | 28869 | [#11] stanford-crypto-ccm Cycles:10 Average:155.60 Median:151.50 stddev:22.37 (14.8%) stddev-sans-first:23.66 08:07:20 INFO - PROCESS | 28869 | Values: 151.0 145.0 144.0 153.0 149.0 143.0 161.0 141.0 217.0 152.0 08:07:20 INFO - PROCESS | 28869 | 08:07:20 INFO - PROCESS | 28869 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.10 Median:180.50 stddev:4.91 (2.7%) stddev-sans-first:5.21 08:07:20 INFO - PROCESS | 28869 | Values: 181.0 179.0 193.0 177.0 180.0 178.0 176.0 180.0 185.0 182.0 08:07:20 INFO - PROCESS | 28869 | 08:07:20 INFO - PROCESS | 28869 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.50 stddev:3.46 (4.8%) stddev-sans-first:3.66 08:07:20 INFO - PROCESS | 28869 | Values: 72.0 70.0 71.0 69.0 70.0 68.0 68.0 72.0 80.0 72.0 08:07:20 INFO - PROCESS | 28869 | -------- Summary: end -------- 08:07:20 INFO - PROCESS | 28869 | 08:07:22 INFO - TEST-INFO | 28869: exit 0 08:07:22 INFO - TEST-OK | kraken | took 65219ms 08:07:22 INFO - SUITE-END | took 1188s 08:07:22 INFO - Completed test suite (00:19:48) 08:07:22 INFO - javascript benchmark 08:07:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2616.1628278950734, 2648.615950687149, 2681.6916054653707, 2686.3821321096148, 2686.570148776196, 4541.977290113553, 4608.5852273295395, 4722.126406614774, 4807.711537307764, 4840.612750979917, 4625.745583992879, 4731.1956967315555, 4749.8812529686775, 4762.119007983517, 4798.448178459478, 4294.763787991659, 4306.289462238727, 4357.128574285156, 4385.561443855605, 4482.484514280851, 4290.2706539888295, 4382.298832186851, 4400.295952647577, 4430.26900561407, 4476.48520420151, 4239.0885959518855, 4277.1873344064525, 4400.317950717644, 4464.6428285737065, 4498.595126438619, 4287.356896465524, 4313.611774940239, 4319.07139964909, 4351.477822661301, 4446.55534446556, 4320.762358070305, 4347.3696314034605, 4349.238883195429, 4356.934645980313, 4401.119776044804, 4703.50613185614, 4717.268823332389, 4736.431628204603, 4741.668083234175, 4747.098051370263, 4899.461059283476, 4948.1093403187415, 4950.579200767939, 5047.470015648378, 5101.132807422747, 5163.483651634844, 5164.122099243138, 5199.168133098686, 5202.713850738246, 5214.061468935628, 4756.262779269219, 4769.213079841857, 4785.808567657289, 4794.880127996758, 4825.445073816486, 4966.230234313687, 5179.04187725272, 5203.19350500673, 5205.24523944026, 5258.39528454225, 4823.517648235219, 4902.0, 4903.901921961541, 5011.649184557119, 5018.974905125451, 5015.874603134951, 5017.799288028438, 5026.246063090565, 5029.748512574357, 5082.440931497532, 4943.184374578226, 4957.950420495821, 5000.724960127228, 5045.217991211368, 5057.0, 4821.0, 4874.073925954058, 4877.365942427462, 4906.386701662293, 4966.751662416865, 4363.2800587903275, 4435.401220835146, 4439.467263928284, 4471.441069866267, 4484.327350897392, 3842.193139440749, 3851.1912498375655, 3851.8844434667003, 3875.844966201377, 3888.5528164260904, 4207.663386929038, 4265.850695225714, 4418.5802348776815, 4421.690481666253, 4470.083632855257, 5033.219850923113, 5074.543291103744, 5095.974520127375, 5132.717700526507, 5150.948490515047, 4388.0, 4391.7145385550475, 4405.3612226227015, 4405.537418571068, 4432.3351497275025, 4433.977830110829, 4613.746243956614, 4614.792334344963, 4628.490866004737, 4672.486026537078, 4603.953960460352, 4652.069586082865, 4666.300054991779, 4668.673192876466, 4670.229412146958, 4943.703377797344, 5004.0, 5015.924761128513, 5017.397912250407, 5017.62367822422, 4656.41794775653, 4668.603168730696, 4670.813167473399, 4672.065586882569, 4673.929891051569, 4919.409670839379, 4921.9015619688125, 4922.3600931880055, 4923.163062279349, 4923.852284431473, 5023.723695196799, 5031.069252188357, 5066.569341606005, 5066.569341606005, 5072.239164125263, 4933.038057578738, 4935.383077115361, 4939.678920870132, 4941.382327209099, 4945.604351651931, 4859.781309840995, 4859.829905953275, 4866.075445665312, 4916.041371932439, 4974.527419895104, 4850.296706977398, 4861.538153875376, 4869.342638743724, 4876.90246195067, 4935.925961110658, 4832.975835120802, 4876.097921884463, 4894.412670479565, 4926.3349447824085, 4965.354503914468, 4828.179209534317, 4897.926531102107, 4933.605311575137, 4939.925901111558, 4945.777440015136], "value": 4644.49612408043, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.0154179415127, 565.9122835960425, 580.9041508151155, 585.3911931591143, 586.6538742142138, 27062.0, 29831.85084074582, 29857.55213671794, 29863.552046719316, 37413.43879841798, 37211.4418283726, 37982.25221847269, 37982.620173798256, 37995.430068548994, 38057.23885522288, 7516.248375162468, 7655.770326890202, 7657.081150261976, 7661.693532258703, 7665.731699390522, 7245.420366370704, 7448.776536703907, 7590.6963721451075, 7678.0, 7685.462017658766, 7567.697292108309, 7595.202503737111, 7622.923770762277, 9648.276379271547, 9906.257030722689, 9848.458334791583, 9945.950270248675, 9948.403095814201, 9948.452835094067, 9950.452725100153, 9624.759381015461, 9683.41899486033, 9698.466584337859, 9706.417614943055, 9711.417314961054, 36060.63939360599, 36371.81814090939, 36399.0, 36420.27159456823, 36442.088947776254, 2799.8740056697497, 2887.6823549409546, 2897.3915477749697, 2945.808522446034, 3531.2231309111953, 26680.0, 26795.33011674704, 26805.32986675329, 26876.46247075067, 27067.187984360502, 3057.464943634855, 3101.1006808025872, 3124.98437507811, 3147.5436061770915, 3149.1812128846664, 251431.0, 252766.34887941147, 253246.0, 253781.0, 254283.0, 52646.0, 53220.669483262456, 53264.0, 53287.46712532903, 53364.46635533595, 54686.0, 54746.0, 54757.45242547603, 54808.72595637076, 54814.72592637011, 13879.0, 14401.351939162763, 14414.783778243334, 14420.278986050656, 14434.783478247835, 11053.778924421627, 11117.388543630179, 11126.499307531181, 11127.054200392895, 11127.777444451065, 16700.74131096587, 17287.74068388975, 17346.739798903025, 17453.38913138034, 17483.125843707763, 5272.762725677354, 6456.322086180978, 6575.4410875076155, 6853.931460685429, 7119.394851437686, 766.6435107674846, 915.3409545127497, 928.9767755806024, 936.6581197862731, 987.7382493639192, 25714.35714107162, 26750.5987410189, 27077.458450830873, 27177.592336114973, 27286.0, 918.6509126532009, 924.0297687428174, 955.2119501411363, 990.1781521337273, 1015.020913618532, 14441.0, 14501.419943202154, 14623.976321657381, 14709.190994495191, 14851.0, 342690.0, 348813.0, 349086.0, 349934.0, 350387.0, 46779.15260592426, 47587.286190707164, 47621.28568071482, 47643.76178119087, 47653.5234647656, 1103.475848971732, 1135.795556799784, 1140.9543618255343, 1144.994275028603, 1150.6950658075616, 24610.630840537764, 25922.0, 26883.462330752885, 26907.596386053832, 26916.327091822863, 40489.392659109544, 40527.1894562113, 40781.388279176426, 40839.38740918948, 40974.385384218665, 291217.0, 293600.0, 294106.0, 294454.0, 294740.73629691434, 23448.413789654714, 24428.511429770948, 24432.63351049771, 24444.388890277885, 24450.266492005267, 39496.0, 39601.40597890977, 39648.0, 40019.599804002755, 40891.18217635571, 33846.66153338435, 33884.0, 34003.0, 34023.48964765481, 34069.829650851585, 33044.669553305124, 33523.497147542315, 33771.83114084512, 34091.488627671104, 34658.0, 33438.331233375684, 33541.83229083839, 33585.16037099092, 33759.4936075964, 33785.15537111592, 25712.61431078498, 25962.22113336603, 28788.280292992844, 29314.7068529312, 29711.40577188401, 22567.529769040015, 23448.531029378977, 23470.530589388458, 23543.0, 23730.169444069375], "value": 16967.760315989148, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.29553346904567, 352.34815591156365, 361.3639993611244, 370.75715406408796, 379.59573054696745, 11741.53033878645, 12392.81410778838, 12904.354782260896, 13427.261500617462, 16054.357825686988, 15912.0, 16125.193740312967, 16126.75809862853, 16234.350625974947, 16245.0, 4712.3638308828295, 4946.554810067093, 4995.175795993657, 5252.6848389096585, 5294.735263236842, 5303.920441193385, 5337.893242135155, 5344.011357898782, 5346.224797404374, 5349.652272602269, 3366.1584603849037, 3451.3442445935316, 3538.5046093546925, 5354.196870469422, 5355.518003379695, 5422.53908417785, 5427.972860135694, 5428.131498960148, 5431.348238211401, 5433.7283135843445, 4532.841350552748, 4826.624412042551, 4856.830010949635, 4914.557689807934, 4916.827911023132, 11719.531218751239, 11871.881281187163, 11876.643700688994, 11935.104867135, 11958.804119588058, 1774.1218097041917, 1786.428342930263, 1799.1004497751123, 1828.579426731859, 2134.4983928776724, 8751.0, 8955.910440895574, 9697.515124243759, 9904.108630223314, 12969.221846689228, 1552.6351307442856, 1585.1994742654886, 1658.461000174948, 1670.5489517830117, 1737.504811128835, 64745.0, 66627.0, 68105.3189468104, 68650.0, 69525.95711064288, 9582.472963987047, 9639.90360096404, 9764.229103032554, 9953.104220620178, 9971.501424928725, 13387.0, 13412.664683382993, 13422.0, 13423.798643020362, 13452.663683407993, 6622.801315960529, 6698.0, 6862.656867156622, 6874.106366172366, 7116.359527642537, 6367.0, 6384.138141350951, 6428.296501427126, 6484.286728459866, 6703.229128650268, 4218.346156345771, 4241.936370954438, 4244.660427165819, 4267.1892340455215, 4347.695661303678, 1651.9091449970126, 1804.49474147239, 1828.3966291123897, 1831.3407173417559, 1841.9447416577525, 747.4095464582919, 758.6775620361435, 800.931920786728, 830.8795224692386, 869.682565863468, 15395.692086158215, 15506.689866202838, 16108.838911610734, 16166.676666466605, 16197.109158996369, 795.2882170457524, 852.8038551133274, 858.4205661178679, 859.3243175807077, 880.5553195636163, 8515.19105684959, 9218.723438296862, 9286.860697089549, 9318.161365477139, 9380.8592871107, 350728.0, 354423.0, 356975.0, 357083.0, 357709.0, 72464.63767681233, 73189.26810731825, 73464.0, 75231.0, 80272.0, 880.5861245214738, 897.6499165325529, 898.0480690467995, 906.6600024990629, 908.2824568590871, 14113.858861411254, 14259.928700356431, 14401.63995900111, 14532.346044428237, 14984.550463486114, 35039.18948565022, 35475.0, 36309.45535816912, 36415.08962275858, 37161.628383716896, 46170.76914615405, 46381.304280436496, 46615.57152070548, 47168.764156179, 49296.0, 6934.826629334307, 6936.79189624312, 7466.701331946661, 7473.290037446434, 7492.363149132385, 10379.0, 10929.836052459379, 11097.112231021338, 11378.658640240807, 11427.371494567878, 9661.71014869555, 9793.804123917624, 10071.143952764098, 10172.84740728875, 10174.491275436347, 9383.671571494964, 9668.75828104303, 9880.901190988287, 10070.597176112873, 10399.376037437778, 9929.3545919515, 9984.750381240527, 10046.095851373411, 10277.897221027693, 10598.841017384591, 7150.141982962078, 7224.313690199423, 7272.600006999666, 7370.852582948204, 7433.9256607433235, 8408.369372297224, 9813.0, 9870.901290987285, 9936.751581210528, 10400.73998150022], "value": 7702.201578474938, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1212.0667086343522, 1300.9674758131048, 1372.9931350343247, 1421.6588018875466, 1652.0665823809547, 6146.293176284728, 6763.0, 6976.372126508613, 6982.755603553876, 7102.57384556927, 6969.407600353976, 7039.401650859683, 7043.119610048744, 7047.330503602149, 7054.2240353561065, 2089.9373018809424, 2119.618468675638, 2121.8302535797097, 2121.957560848782, 2124.097258665061, 1835.5869929265941, 1871.7660292463443, 2030.6547886859269, 2078.1687325069943, 2093.5394213273057, 2003.6794112941932, 2009.969850452237, 2010.7989201079922, 2014.6575082235981, 2016.4353980885376, 2063.2778527515325, 2078.376487053878, 2109.947251318714, 2119.6608542633257, 2122.2572099764957, 1802.8287312705272, 1863.9347622833136, 1866.5333666583354, 1874.1378965675806, 1878.0703551741838, 6847.828804279883, 6954.23503414624, 6965.721371145148, 7191.101112360955, 7279.3084656958035, 4122.464079669624, 4212.831486740527, 4246.63903568194, 4248.235317642823, 4249.32010878258, 2758.917232483029, 2833.3766571354267, 2867.7562407195414, 2887.2926133097317, 2890.898818541341, 896.2605850173633, 902.4675441489487, 927.2072378116748, 942.2320808541017, 946.7443790176613, 9209.125133112344, 9261.21279691227, 9286.953565232197, 9347.626094956193, 9560.187384072362, 3676.5955744868043, 3725.2549490102087, 3748.3253014457114, 3762.62373762627, 3808.7524310919703, 7399.186089530147, 7406.259374062551, 7407.2592740725495, 7411.629418529052, 7412.221716719775, 4284.592963668447, 4286.957130428656, 4291.6566674665955, 4294.119705460374, 4296.3555466680245, 3829.272438236726, 3849.615038496128, 3968.7420317679835, 4041.9797901010306, 4044.5753195914594, 2904.6514418269944, 2913.222934010252, 3004.0, 3015.532592448174, 3038.14931819091, 926.6015613286216, 947.7488465556632, 950.6245033211843, 956.0439560439561, 961.2262128986093, 719.6725489902082, 806.4193780478047, 831.6673330667782, 843.0178841649532, 846.3821361025945, 4685.0, 4763.261694437368, 4764.356811830427, 4830.637702172281, 4844.079624871263, 404.85425246911086, 410.30453381518635, 413.1818998383158, 415.89810496428566, 421.0673358510913, 3403.9659603404143, 3404.2000129969438, 3450.5859296884532, 3452.1197094740683, 3557.768745031565, 7456.7390141344795, 7768.65041073153, 8033.1163572007035, 8448.11294814048, 8548.957255213683, 8674.436161649473, 8674.739757807276, 8675.089115642766, 8675.479471231747, 8678.696245631372, 6272.6236425814595, 6406.359364063556, 6420.550561460653, 6431.006388019729, 6465.15952926126, 4907.116718990616, 4945.406551213878, 5020.146575082172, 5134.743262836769, 5161.354830646169, 7650.655720492702, 7729.304362607392, 7836.960815195887, 7842.725504607311, 7920.564368959763, 7802.375809935305, 8042.276195142465, 8134.83730325402, 8203.261706446448, 8203.753887383387, 6044.425779550936, 6210.503159747119, 6215.65813880241, 6221.813345599639, 6224.221972253468, 6380.87238255223, 6608.173978252718, 6727.798166055026, 6787.253402125663, 6789.728410863708, 6171.660558669317, 6211.3478084800445, 6256.812295631138, 6322.525810564134, 6372.9362706374195, 6025.457708806229, 6072.696365181811, 6090.69546522681, 6093.725782339894, 6117.195427349032, 5576.804811831566, 5586.86032849182, 5623.1846382273525, 5686.744096515749, 5759.395263497272, 4217.093324935154, 4304.246756817607, 4335.501417336921, 4431.4682238130345, 4464.732116073046, 4374.540673229265, 4391.64866810648, 4437.489688685713, 4493.0789188216995, 4561.475430325422], "value": 3699.6350575654133, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.3357808049721, 281.62403191739025, 289.2869077723411, 290.91418031680666, 291.27472593242834, 4810.701110700109, 4865.883340746773, 4894.461609222992, 4898.583620392266, 4930.45764965854, 4705.176594096037, 4721.504242054586, 4797.304390863323, 4807.423109226889, 4819.469858315582, 3502.7723197992113, 3585.6414358564066, 3636.6181550937167, 3653.3971894637352, 3734.0, 3708.7589306694977, 3717.6282371762877, 3722.4044152935535, 3729.254149170163, 3735.8318875650525, 3661.0, 3671.4492826076034, 3682.1162920898923, 3684.44733290006, 3699.981500092496, 3465.8267086645565, 3578.9642103579154, 3588.3182195382924, 3707.8146092695256, 3717.4052151655605, 3257.1368587324378, 3268.248302890325, 3270.3295824356187, 3270.460374038281, 3273.116258610186, 4610.700304480198, 4622.768861556909, 4623.768811559442, 4641.791119399635, 4649.071085216292, 4067.491563554556, 4231.407602935591, 4235.618794308527, 4236.766977816219, 4241.936370954438, 4979.584901322855, 4986.40163180417, 4988.476209997971, 4990.0, 4998.9500104999215, 3583.7491375603718, 3591.3894637911617, 3592.2456284180353, 3599.6220396858216, 3604.7296452765886, 5137.101007323703, 5235.240890070956, 5247.606429517801, 5249.370075590953, 5286.127788914863, 3630.8729194478597, 3654.9634503655157, 3656.780593164419, 3668.3947148720695, 3669.522962014921, 3701.2597480504005, 3710.9814450927574, 3718.0, 3721.7953012584567, 3723.236736469017, 4213.199492096492, 4216.409702641633, 4222.303319952173, 4223.128272774481, 4229.281022226229, 4813.3983252093485, 4926.0, 4969.378827646544, 4983.775730092155, 5036.665283699749, 1225.2403509823966, 1226.7117227451542, 1226.7362517058875, 1231.7228623559806, 1236.9876301236873, 795.9562224077731, 822.6837060702948, 857.7341024282367, 867.5965675960582, 871.6034204436966, 4198.1393814268, 4297.39836422901, 4474.239379305526, 4481.193385190697, 4492.8094055075435, 5171.500264923206, 5171.612129090333, 5173.586113110942, 5176.327077479904, 5176.861090560071, 4466.798994045275, 4483.50681425043, 4490.977545112253, 4498.167838949805, 4508.661850361236, 2532.670752802124, 2635.881385337626, 2652.6949400819153, 2654.6947101083238, 2658.3354161459633, 4655.348251244828, 4660.743659098782, 4677.146940366374, 4678.906421871544, 4697.177993851063, 4849.817582088074, 5142.61430392722, 5144.6655967362, 5156.813932795478, 5165.856169689612, 4661.813527458864, 4686.617447852892, 4735.786889590046, 4737.336772851803, 4738.455077666113, 5007.649464537593, 5008.248762685626, 5027.74861256943, 5030.496950304941, 5052.8484145475695, 4653.255479123324, 4870.853874383774, 4875.512448755097, 4926.359573255454, 4936.777844997056, 4646.953530464652, 4677.269410318204, 4688.695234809727, 4694.812207511662, 4707.223308154116, 3465.514827924143, 3467.271872906617, 3470.5314782505047, 3501.5272938154044, 3508.5965114012215, 5061.266116413173, 5066.164082926276, 5071.112555302881, 5074.923876141935, 5088.211327244283, 4709.5055019223855, 4868.391451068616, 4875.90248195027, 4876.512348765095, 4881.560659540658, 4845.8061677533915, 4871.707697538159, 4873.245631572702, 4878.121938051185, 4891.119598472309, 4692.859214223578, 4720.575148236675, 4724.149653062482, 4748.762561871962, 4758.000819827875, 4720.433547974265, 4884.340614017062, 5062.140345268584, 5068.467810879804, 5097.0, 4933.284673722218, 4938.333325001223, 4938.950610493849, 4944.3572335596145, 4948.505149485023], "value": 3720.5528964702603, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.4473845907912, 620.7516993202721, 633.8193614819775, 694.4617921111138, 709.1206903439736, 11881.52473901044, 12981.091323607352, 13005.284709340982, 13008.0, 13013.414396352151, 12123.0, 12335.383230838444, 12368.381580920963, 12382.31897245651, 12402.193857399285, 613.4816080412045, 626.9153664255335, 736.3887972982425, 736.8526294741073, 741.7070257248383, 769.3768047881206, 772.5326177662517, 772.7565816767728, 773.1456740301969, 773.1997382708897, 815.339574944297, 815.4617952151581, 816.147126253064, 816.1634324817051, 816.7876352148425, 645.7094307561592, 664.9368310010566, 768.9115751688571, 790.9248621380959, 797.1908512859452, 588.8881112588638, 589.3163929841363, 590.6485641043615, 590.8759160576284, 591.0808692483187, 12185.939070304592, 12206.938965305206, 12223.14437989341, 12230.205036672676, 12238.938805306005, 11976.940115299367, 11980.760384792255, 12010.939945300304, 12081.87918120825, 12408.62774116778, 9377.249820014382, 9443.0, 9561.378510396871, 9599.616015359377, 9694.709158725249, 3898.5321761388814, 3920.627540383659, 3954.920901581981, 3985.601439855991, 4034.959650403517, 45335.77332113318, 46081.30878036832, 46195.997260178316, 46347.768261158475, 46941.29588056182, 9443.858342124873, 9484.905150948402, 9571.712848614552, 9688.0, 10075.34510256831, 17212.655746884993, 17249.655006899793, 17255.91372043157, 17387.565310867078, 17390.913045434692, 6332.398422149889, 6347.39699728525, 6361.872762544724, 6370.203724534434, 6374.171357723466, 3435.2270739084006, 3554.0759402555523, 3694.5012423323046, 3704.148045949447, 3713.517242758424, 2492.1651246832516, 2580.1614475295605, 2585.7414258574368, 2586.728393518691, 2589.3397183718407, 391.81193027347035, 452.63336697275315, 455.65142665860645, 464.8721601559598, 470.1185277604492, 442.35416292213085, 470.7999100382392, 479.6234955559869, 594.5481434110108, 603.4659326496082, 7614.162442131361, 7853.0, 8099.392545559107, 8142.557232830127, 8201.79495512605, 562.4066609726777, 571.6128712134353, 573.0258560447256, 573.3807487913044, 584.9327327357408, 3806.0, 3969.2458432897656, 3977.721559490808, 3999.7000224983244, 4091.447654566655, 41407.585924140374, 51300.48699512957, 53276.200856987176, 53606.731966340696, 61017.69491152604, 53055.469445305054, 54291.75644800819, 54918.72540637351, 54946.0, 55094.0, 49396.259056114184, 49497.0, 49755.25367119424, 50377.74811125994, 52403.47596523986, 8195.385346098947, 8320.167983201873, 8513.787155320919, 8645.308375330083, 8769.91230087691, 35188.0, 35674.46488302626, 35847.46228806518, 36129.27741445209, 36233.63766362303, 46737.0, 47396.7630161847, 48134.759326203144, 48488.757556212, 50541.74729126478, 8717.0, 9096.363254572116, 9102.180803727697, 10027.799444011225, 10116.59533618647, 11474.483648236017, 11569.074474042225, 11859.52561897549, 12070.27578345302, 12486.625401237978, 11009.339439633648, 11108.333499990027, 11133.0, 11219.326840389604, 11244.156688248251, 11195.263081692921, 11599.536018559163, 11922.0, 11966.401679916144, 12309.13836031505, 11405.828912566152, 11470.770584588428, 11534.0, 11744.236624619372, 12340.259584424963, 9234.538273086184, 9297.911765733983, 9758.414495130315, 10147.441890695787, 10157.593696252066, 8888.644454222018, 9298.814023719622, 9767.267454940766, 9847.212223021997, 9880.950595246977], "value": 5936.229628492579, "unit": "score"}], "name": "dromaeo_css", "value": 6061.563449191518, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 114.0, 115.0, 113.0, 113.0, 115.0, 116.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 128.0, 165.0, 136.0, 136.0, 128.0, 128.0, 164.0, 130.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 161.0, 162.0, 163.0, 166.0, 162.0, 161.0, 161.0, 160.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 108.0, 77.0, 77.0, 77.0, 76.0, 92.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 108.0, 83.0, 84.0, 83.0, 97.0, 82.0, 82.0, 107.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 97.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 73.0, 64.0, 65.0, 64.0, 64.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 68.0, 67.0, 66.0, 69.0, 67.0, 67.0, 70.0], "value": 67.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 85.0, 86.0, 86.0, 86.0, 85.0, 85.0, 86.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 145.0, 144.0, 153.0, 149.0, 143.0, 161.0, 141.0, 217.0, 152.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 179.0, 193.0, 177.0, 180.0, 178.0, 176.0, 180.0, 185.0, 182.0], "value": 181.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 71.0, 69.0, 70.0, 68.0, 68.0, 72.0, 80.0, 72.0], "value": 71.2, "unit": "score"}], "name": "kraken", "value": 1571.9999999999998, "alertThreshold": 2.0}]} 08:07:22 INFO - Return code: 0 08:07:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:07:22 INFO - # TBPL SUCCESS # 08:07:22 INFO - Running post-action listener: _resource_record_post_action 08:07:22 INFO - [mozharness: 2016-11-24 16:07:22.697458Z] Finished run-tests step (success) 08:07:22 INFO - Running post-run listener: _resource_record_post_run 08:07:22 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 122880; Write bytes: 406761472; Read time: 204; Write time: 218776 08:07:22 INFO - TinderboxPrint: CPU usage
13.1% 08:07:22 INFO - TinderboxPrint: I/O read bytes / time
122,880 / 204 08:07:22 INFO - TinderboxPrint: I/O write bytes / time
406,761,472 / 218,776 08:07:22 INFO - TinderboxPrint: CPU idle
8,354.2 (86.9%) 08:07:22 INFO - TinderboxPrint: CPU user
1,210.9 (12.6%) 08:07:22 INFO - TinderboxPrint: Swap in / out
0 / 0 08:07:22 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 53248; Write bytes: 115822592; Read time: 172; Write time: 45056 08:07:22 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 65536; Write bytes: 290013184; Read time: 20; Write time: 173692 08:07:23 INFO - Running post-run listener: _upload_blobber_files 08:07:23 INFO - Blob upload gear active. 08:07:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:07:23 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 08:07:23 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:07:23 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:07:23 INFO - (blobuploader) - INFO - Open directory for files ... 08:07:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:07:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:07:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:24 INFO - (blobuploader) - INFO - Done attempting. 08:07:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:07:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:07:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:27 INFO - (blobuploader) - INFO - Done attempting. 08:07:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:07:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:07:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:28 INFO - (blobuploader) - INFO - Done attempting. 08:07:28 INFO - (blobuploader) - INFO - Iteration through files over. 08:07:28 INFO - Return code: 0 08:07:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:07:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:07:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02373f352008334ef215c5b60e8adf03284d8edd3ec1904909954513aa331fa176cdca14535c61514028a5d1f457d6cd2ea6140b12ce65d767ff467a63d92d14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7934161877217da4185fd9a767851d78ac9c173c045bd6b13d26025278b23270f359e1b40a9593cca0aaab8896b60ed059e4a719d4a583b0d04b38121291787", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82d4ecda402afa252e4a31c1db54d5612a388aa711849b7d9d4ecad8dddbf55709eb18805ac2968de5346f7dd85e5b1ebee472aa22d3997254c8a5336ec12c28"} 08:07:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:07:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:07:28 INFO - Contents: 08:07:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02373f352008334ef215c5b60e8adf03284d8edd3ec1904909954513aa331fa176cdca14535c61514028a5d1f457d6cd2ea6140b12ce65d767ff467a63d92d14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7934161877217da4185fd9a767851d78ac9c173c045bd6b13d26025278b23270f359e1b40a9593cca0aaab8896b60ed059e4a719d4a583b0d04b38121291787", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82d4ecda402afa252e4a31c1db54d5612a388aa711849b7d9d4ecad8dddbf55709eb18805ac2968de5346f7dd85e5b1ebee472aa22d3997254c8a5336ec12c28"} 08:07:28 INFO - Running post-run listener: copy_logs_to_upload_dir 08:07:28 INFO - Copying logs to upload dir... 08:07:28 INFO - mkdir: /builds/slave/test/build/upload/logs 08:07:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.737453 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-24 08:07:28.293623) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 08:07:28.297074) ========= 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=232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02373f352008334ef215c5b60e8adf03284d8edd3ec1904909954513aa331fa176cdca14535c61514028a5d1f457d6cd2ea6140b12ce65d767ff467a63d92d14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7934161877217da4185fd9a767851d78ac9c173c045bd6b13d26025278b23270f359e1b40a9593cca0aaab8896b60ed059e4a719d4a583b0d04b38121291787", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82d4ecda402afa252e4a31c1db54d5612a388aa711849b7d9d4ecad8dddbf55709eb18805ac2968de5346f7dd85e5b1ebee472aa22d3997254c8a5336ec12c28"} build_url:https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011616 build_url: 'https://queue.taskcluster.net/v1/task/AOBDaB09RsmSAV_etpVWLA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02373f352008334ef215c5b60e8adf03284d8edd3ec1904909954513aa331fa176cdca14535c61514028a5d1f457d6cd2ea6140b12ce65d767ff467a63d92d14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7934161877217da4185fd9a767851d78ac9c173c045bd6b13d26025278b23270f359e1b40a9593cca0aaab8896b60ed059e4a719d4a583b0d04b38121291787", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82d4ecda402afa252e4a31c1db54d5612a388aa711849b7d9d4ecad8dddbf55709eb18805ac2968de5346f7dd85e5b1ebee472aa22d3997254c8a5336ec12c28"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 08:07:28.323381) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 08:07:28.323781) ========= 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=232498196343f89f466a4a9a000001c8-1480001692.903281-1035405096 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 08:07:28.407614) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 08:07:28.407943) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 08:07:28.408242) ========= ========= Total master_lag: 0.17 =========