builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1490482989.08 results: success (0) revision: 2ecf610d3185de940cb7b4ed2c214dc9e2367cee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-25 16:03:09.078144) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-25 16:03:09.078637) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-25 16:03:09.078930) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-25 16:03:09.093580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 16:03:09.093880) ========= 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=4300f881736b422476174874000001bc-1490480327.798592-1876497116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-25 16:03:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2017-03-25 16:03:10 (42.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080439 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 16:03:09.188183) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 16:03:09.188467) ========= 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=4300f881736b422476174874000001bc-1490480327.798592-1876497116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018248 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 16:03:09.237487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 16:03:09.237802) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2ecf610d3185de940cb7b4ed2c214dc9e2367cee --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 2ecf610d3185de940cb7b4ed2c214dc9e2367cee --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=4300f881736b422476174874000001bc-1490480327.798592-1876497116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-25 16:03:10,321 truncating revision to first 12 chars 2017-03-25 16:03:10,321 Setting DEBUG logging. 2017-03-25 16:03:10,321 attempt 1/10 2017-03-25 16:03:10,321 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2ecf610d3185?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-25 16:03:10,791 unpacking tar archive at: mozilla-central-2ecf610d3185/testing/mozharness/ program finished with exit code 0 elapsedTime=0.785906 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 16:03:10.037368) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-25 16:03:10.037687) ========= script_repo_revision: 2ecf610d3185de940cb7b4ed2c214dc9e2367cee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-25 16:03:10.038057) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-25 16:03:10.038319) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-25 16:03:10.048063) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-03-25 16:03:10.048394) ========= /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=4300f881736b422476174874000001bc-1490480327.798592-1876497116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:03:11 INFO - MultiFileLogger online at 20170325 16:03:11 in /builds/slave/test 16:03:11 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 16:03:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:03:11 INFO - {'append_to_log': False, 16:03:11 INFO - 'base_work_dir': '/builds/slave/test', 16:03:11 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:03:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:03:11 INFO - 'branch': 'Firefox-Non-PGO', 16:03:11 INFO - 'buildbot_json_path': 'buildprops.json', 16:03:11 INFO - 'config_files': ('talos/linux_config.py',), 16:03:11 INFO - 'default_actions': ('clobber', 16:03:11 INFO - 'read-buildbot-config', 16:03:11 INFO - 'download-and-extract', 16:03:11 INFO - 'populate-webroot', 16:03:11 INFO - 'create-virtualenv', 16:03:11 INFO - 'install', 16:03:11 INFO - 'run-tests'), 16:03:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:03:11 INFO - 'download_minidump_stackwalk': True, 16:03:11 INFO - 'download_symbols': 'ondemand', 16:03:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:03:11 INFO - 'tooltool.py': '/tools/tooltool.py', 16:03:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:03:11 INFO - '/tools/misc-python/virtualenv.py')}, 16:03:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:03:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:03:11 INFO - 'gecko_profile': False, 16:03:11 INFO - 'gecko_profile_interval': 0, 16:03:11 INFO - 'installer_path': 'installer.exe', 16:03:11 INFO - 'log_level': 'info', 16:03:11 INFO - 'log_name': 'talos', 16:03:11 INFO - 'log_to_console': True, 16:03:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:03:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:03:11 INFO - 'opt_config_files': (), 16:03:11 INFO - 'pip_index': False, 16:03:11 INFO - 'suite': 'dromaeojs', 16:03:11 INFO - 'system_bits': '32', 16:03:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:03:11 INFO - 'title': 'talos-linux64-ix-045', 16:03:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:03:11 INFO - 'use_talos_json': True, 16:03:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:03:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:03:11 INFO - 'work_dir': 'build'} 16:03:11 INFO - [mozharness: 2017-03-25 23:03:11.225905Z] Running clobber step. 16:03:11 INFO - Running pre-action listener: _resource_record_pre_action 16:03:11 INFO - Running main action method: clobber 16:03:11 INFO - rmtree: /builds/slave/test/build 16:03:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:03:12 INFO - Running post-action listener: _resource_record_post_action 16:03:12 INFO - [mozharness: 2017-03-25 23:03:12.158960Z] Finished clobber step (success) 16:03:12 INFO - [mozharness: 2017-03-25 23:03:12.159060Z] Running read-buildbot-config step. 16:03:12 INFO - Running pre-action listener: _resource_record_pre_action 16:03:12 INFO - Running main action method: read_buildbot_config 16:03:12 INFO - Using buildbot properties: 16:03:12 INFO - { 16:03:12 INFO - "project": "", 16:03:12 INFO - "product": "firefox", 16:03:12 INFO - "who": "philringnalda@gmail.com", 16:03:12 INFO - "installer_path": "public/build/target.tar.bz2", 16:03:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:03:12 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:03:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 16:03:12 INFO - "stage_platform": "linux64", 16:03:12 INFO - "basedir": "/builds/slave/test", 16:03:12 INFO - "buildnumber": 1033, 16:03:12 INFO - "platform": "ubuntu64_hw", 16:03:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:03:12 INFO - "slavebuilddir": "test", 16:03:12 INFO - "taskId": "XdtfsupYR8CtfcGyJ6gZvg", 16:03:12 INFO - "branch": "mozilla-central", 16:03:12 INFO - "script_repo_revision": "production", 16:03:12 INFO - "revision": "2ecf610d3185de940cb7b4ed2c214dc9e2367cee", 16:03:12 INFO - "slavename": "talos-linux64-ix-045", 16:03:12 INFO - "repo_path": "mozilla-central" 16:03:12 INFO - } 16:03:12 INFO - Finding installer, test and symbols from parent task. 16:03:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XdtfsupYR8CtfcGyJ6gZvg'}, attempt #1 16:03:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XdtfsupYR8CtfcGyJ6gZvg'}, attempt #1 16:03:13 INFO - Task dependencies: A-ewyOJcScak6p9O5Ujp2g 16:03:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g'}, attempt #1 16:03:13 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.tar.bz2 16:03:13 INFO - Set test_url: https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/test_packages.json 16:03:13 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.crashreporter-symbols.zip 16:03:13 INFO - Running post-action listener: _resource_record_post_action 16:03:13 INFO - [mozharness: 2017-03-25 23:03:13.638168Z] Finished read-buildbot-config step (success) 16:03:13 INFO - [mozharness: 2017-03-25 23:03:13.638389Z] Running download-and-extract step. 16:03:13 INFO - Running pre-action listener: _resource_record_pre_action 16:03:13 INFO - Running main action method: download_and_extract 16:03:13 INFO - mkdir: /builds/slave/test/build/tests 16:03:13 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')]} 16:03:13 INFO - trying https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.test_packages.json 16:03:13 INFO - Downloading https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:03:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:03:14 INFO - Downloaded 986 bytes. 16:03:14 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:03:14 INFO - Using the following test package requirements: 16:03:14 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:03:14 INFO - u'common': [u'target.common.tests.zip'], 16:03:14 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:03:14 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:03:14 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:03:14 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:03:14 INFO - u'mozbase': [u'target.common.tests.zip'], 16:03:14 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:03:14 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:03:14 INFO - u'web-platform': [u'target.common.tests.zip', 16:03:14 INFO - u'target.web-platform.tests.zip'], 16:03:14 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:03:14 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:03:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.common.tests.zip 16:03:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:03:14 INFO - Fetch https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.common.tests.zip into memory 16:03:15 INFO - Expected file size: 58128600 16:03:15 INFO - Obtained file size: 58128600 16:03:25 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:03:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.common.tests.zip 16:03:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:03:25 INFO - Fetch https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.common.tests.zip into memory 16:03:26 INFO - Expected file size: 58128600 16:03:26 INFO - Obtained file size: 58128600 16:03:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.talos.tests.zip 16:03:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:03:37 INFO - Fetch https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.talos.tests.zip into memory 16:03:38 INFO - Expected file size: 14404171 16:03:38 INFO - Obtained file size: 14404171 16:03:38 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')]} 16:03:38 INFO - trying https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.tar.bz2 16:03:38 INFO - Downloading https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:03:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:03:39 INFO - Downloaded 62629100 bytes. 16:03:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.tar.bz2 16:03:39 INFO - mkdir: /builds/slave/test/properties 16:03:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:03:39 INFO - Writing to file /builds/slave/test/properties/build_url 16:03:39 INFO - Contents: 16:03:39 INFO - build_url:https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.tar.bz2 16:03:39 INFO - Running post-action listener: _resource_record_post_action 16:03:39 INFO - Running post-action listener: set_extra_try_arguments 16:03:39 INFO - [mozharness: 2017-03-25 23:03:39.795877Z] Finished download-and-extract step (success) 16:03:39 INFO - [mozharness: 2017-03-25 23:03:39.796000Z] Running populate-webroot step. 16:03:39 INFO - Running pre-action listener: _resource_record_pre_action 16:03:39 INFO - Running main action method: populate_webroot 16:03:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:03:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:03:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:03:39 INFO - '--tppagecycles', 16:03:39 INFO - '7'], 16:03:39 INFO - 'tests': ['tsvgm']}}, 16:03:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:03:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:03:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:03:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:03:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:03:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:03:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:03:39 INFO - 'talos_options': ['--disable-e10s'], 16:03:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:03:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:03:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:03:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:03:39 INFO - 'talos_options': ['--disable-e10s'], 16:03:39 INFO - 'tests': ['damp', 'tps']}, 16:03:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:03:39 INFO - 'tests': ['damp', 'tps']}, 16:03:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:03:39 INFO - 'tests': ['dromaeo_dom']}, 16:03:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:03:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:03:39 INFO - 'tests': ['basic_compositor_video']}, 16:03:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:03:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:03:39 INFO - 'tests': ['a11yr', 16:03:39 INFO - 'ts_paint', 16:03:39 INFO - 'tpaint', 16:03:39 INFO - 'sessionrestore', 16:03:39 INFO - 'sessionrestore_no_auto_restore', 16:03:39 INFO - 'tabpaint']}, 16:03:39 INFO - 'other-e10s': {'tests': ['a11yr', 16:03:39 INFO - 'ts_paint', 16:03:39 INFO - 'tpaint', 16:03:39 INFO - 'sessionrestore', 16:03:39 INFO - 'sessionrestore_no_auto_restore', 16:03:39 INFO - 'tabpaint']}, 16:03:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:03:39 INFO - 'ts_paint', 16:03:39 INFO - 'tpaint', 16:03:39 INFO - 'sessionrestore', 16:03:39 INFO - 'sessionrestore_no_auto_restore', 16:03:39 INFO - 'tabpaint']}, 16:03:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:03:39 INFO - 'ts_paint', 16:03:39 INFO - 'tpaint', 16:03:39 INFO - 'sessionrestore', 16:03:39 INFO - 'sessionrestore_no_auto_restore', 16:03:39 INFO - 'tabpaint']}, 16:03:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:03:39 INFO - 'tests': ['a11yr', 16:03:39 INFO - 'ts_paint', 16:03:39 INFO - 'tpaint', 16:03:39 INFO - 'sessionrestore', 16:03:39 INFO - 'sessionrestore_no_auto_restore', 16:03:39 INFO - 'tabpaint']}, 16:03:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:03:39 INFO - 'tests': ['a11yr', 16:03:39 INFO - 'ts_paint', 16:03:39 INFO - 'tpaint', 16:03:39 INFO - 'sessionrestore', 16:03:39 INFO - 'sessionrestore_no_auto_restore', 16:03:39 INFO - 'tabpaint']}, 16:03:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:03:39 INFO - 'tests': ['tsvgx', 16:03:39 INFO - 'tsvgr_opacity', 16:03:39 INFO - 'tart', 16:03:39 INFO - 'tscrollx', 16:03:39 INFO - 'cart', 16:03:39 INFO - 'tsvg_static']}, 16:03:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:03:39 INFO - 'tsvgr_opacity', 16:03:39 INFO - 'tart', 16:03:39 INFO - 'tscrollx', 16:03:39 INFO - 'cart', 16:03:39 INFO - 'tsvg_static']}, 16:03:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:03:39 INFO - 'talos_options': ['--disable-e10s'], 16:03:39 INFO - 'tests': ['tp5o']}, 16:03:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:03:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:03:39 INFO - 'talos_options': ['--disable-e10s', 16:03:39 INFO - '--xperf_path', 16:03:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:03:39 INFO - 'tests': ['tp5n']}, 16:03:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:03:39 INFO - 'talos_options': ['--xperf_path', 16:03:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:03:39 INFO - 'tests': ['tp5n']}}, 16:03:39 INFO - 'talos.zip': {'path': '', 16:03:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:03:39 INFO - Running post-action listener: _resource_record_post_action 16:03:39 INFO - [mozharness: 2017-03-25 23:03:39.812936Z] Finished populate-webroot step (success) 16:03:39 INFO - [mozharness: 2017-03-25 23:03:39.813026Z] Running create-virtualenv step. 16:03:39 INFO - Running pre-action listener: _resource_record_pre_action 16:03:39 INFO - Running main action method: create_virtualenv 16:03:39 INFO - Creating virtualenv /builds/slave/test/build/venv 16:03:39 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 16:03:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:03:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:03:39 INFO - Using real prefix '/usr' 16:03:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:03:40 INFO - Installing distribute.............................................................................................................................................................................................done. 16:03:42 INFO - Installing pip.................done. 16:03:42 INFO - Return code: 0 16:03:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:03:42 INFO - Reading from file tmpfile_stdout 16:03:42 INFO - Output received: 16:03:42 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) 16:03:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:03:42 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')]} 16:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:42 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')]} 16:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:42 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 0x154a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5290>, '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 0x17e5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6040>, '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': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', '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 16:03:42 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 16:03:42 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 16:03:42 INFO - Using env: {'DISPLAY': ':0', 16:03:42 INFO - 'HOME': '/home/cltbld', 16:03:42 INFO - 'LANG': 'en_US.UTF-8', 16:03:42 INFO - 'LANGUAGE': 'en_US:en', 16:03:42 INFO - 'LOGNAME': 'cltbld', 16:03:42 INFO - 'MAIL': '/var/mail/cltbld', 16:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:42 INFO - 'MOZ_NO_REMOTE': '1', 16:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:42 INFO - 'NO_EM_RESTART': '1', 16:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:42 INFO - 'PWD': '/builds/slave/test', 16:03:42 INFO - 'SHELL': '/bin/bash', 16:03:42 INFO - 'SHLVL': '1', 16:03:42 INFO - 'TERM': 'linux', 16:03:42 INFO - 'TMOUT': '86400', 16:03:42 INFO - 'USER': 'cltbld', 16:03:42 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', 16:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:42 INFO - '_': '/tools/buildbot/bin/python'} 16:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:42 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 16:03:42 INFO - Cleaning up... 16:03:42 INFO - Return code: 0 16:03:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:03:42 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')]} 16:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:42 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')]} 16:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:42 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 0x154a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5290>, '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 0x17e5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6040>, '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': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', '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 16:03:42 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 16:03:42 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 16:03:42 INFO - Using env: {'DISPLAY': ':0', 16:03:42 INFO - 'HOME': '/home/cltbld', 16:03:42 INFO - 'LANG': 'en_US.UTF-8', 16:03:42 INFO - 'LANGUAGE': 'en_US:en', 16:03:42 INFO - 'LOGNAME': 'cltbld', 16:03:42 INFO - 'MAIL': '/var/mail/cltbld', 16:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:42 INFO - 'MOZ_NO_REMOTE': '1', 16:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:42 INFO - 'NO_EM_RESTART': '1', 16:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:42 INFO - 'PWD': '/builds/slave/test', 16:03:42 INFO - 'SHELL': '/bin/bash', 16:03:42 INFO - 'SHLVL': '1', 16:03:42 INFO - 'TERM': 'linux', 16:03:42 INFO - 'TMOUT': '86400', 16:03:42 INFO - 'USER': 'cltbld', 16:03:42 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', 16:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:42 INFO - '_': '/tools/buildbot/bin/python'} 16:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:43 INFO - Downloading/unpacking psutil>=3.1.1 16:03:43 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 16:03:43 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 16:03:43 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 16:03:43 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 16:03:43 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 16:03:43 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 16:03:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:03:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:03:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:03:45 INFO - Installing collected packages: psutil 16:03:45 INFO - Running setup.py install for psutil 16:03:45 INFO - building 'psutil._psutil_linux' extension 16:03:45 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 16:03:45 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 16:03:45 INFO - building 'psutil._psutil_posix' extension 16:03:45 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 16:03:45 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 16:03:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:03:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:03:45 INFO - Successfully installed psutil 16:03:45 INFO - Cleaning up... 16:03:45 INFO - Return code: 0 16:03:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:03:45 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')]} 16:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:45 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')]} 16:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:45 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 0x154a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5290>, '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 0x17e5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6040>, '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': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', '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 16:03:45 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 16:03:45 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 16:03:45 INFO - Using env: {'DISPLAY': ':0', 16:03:45 INFO - 'HOME': '/home/cltbld', 16:03:45 INFO - 'LANG': 'en_US.UTF-8', 16:03:45 INFO - 'LANGUAGE': 'en_US:en', 16:03:45 INFO - 'LOGNAME': 'cltbld', 16:03:45 INFO - 'MAIL': '/var/mail/cltbld', 16:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:45 INFO - 'MOZ_NO_REMOTE': '1', 16:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:45 INFO - 'NO_EM_RESTART': '1', 16:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:45 INFO - 'PWD': '/builds/slave/test', 16:03:45 INFO - 'SHELL': '/bin/bash', 16:03:45 INFO - 'SHLVL': '1', 16:03:45 INFO - 'TERM': 'linux', 16:03:45 INFO - 'TMOUT': '86400', 16:03:45 INFO - 'USER': 'cltbld', 16:03:45 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', 16:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:45 INFO - '_': '/tools/buildbot/bin/python'} 16:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:03:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:03:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:03:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:03:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:03:48 INFO - Installing collected packages: mozsystemmonitor 16:03:48 INFO - Running setup.py install for mozsystemmonitor 16:03:48 INFO - Successfully installed mozsystemmonitor 16:03:48 INFO - Cleaning up... 16:03:48 INFO - Return code: 0 16:03:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:03:48 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')]} 16:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:48 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')]} 16:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:48 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 0x154a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5290>, '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 0x17e5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6040>, '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': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', '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 16:03:48 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 16:03:48 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 16:03:48 INFO - Using env: {'DISPLAY': ':0', 16:03:48 INFO - 'HOME': '/home/cltbld', 16:03:48 INFO - 'LANG': 'en_US.UTF-8', 16:03:48 INFO - 'LANGUAGE': 'en_US:en', 16:03:48 INFO - 'LOGNAME': 'cltbld', 16:03:48 INFO - 'MAIL': '/var/mail/cltbld', 16:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:48 INFO - 'MOZ_NO_REMOTE': '1', 16:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:48 INFO - 'NO_EM_RESTART': '1', 16:03:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:48 INFO - 'PWD': '/builds/slave/test', 16:03:48 INFO - 'SHELL': '/bin/bash', 16:03:48 INFO - 'SHLVL': '1', 16:03:48 INFO - 'TERM': 'linux', 16:03:48 INFO - 'TMOUT': '86400', 16:03:48 INFO - 'USER': 'cltbld', 16:03:48 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', 16:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:48 INFO - '_': '/tools/buildbot/bin/python'} 16:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:48 INFO - Downloading/unpacking jsonschema==2.5.1 16:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:03:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:03:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:03:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:03:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:03:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:03:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:03:50 INFO - Downloading functools32-3.2.3-2.tar.gz 16:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:03:50 INFO - warning: no files found matching '*.txt' 16:03:50 INFO - no previously-included directories found matching 'build' 16:03:50 INFO - no previously-included directories found matching 'dist' 16:03:50 INFO - no previously-included directories found matching '.git*' 16:03:50 INFO - Installing collected packages: jsonschema, functools32 16:03:50 INFO - Running setup.py install for functools32 16:03:50 INFO - warning: no files found matching '*.txt' 16:03:50 INFO - no previously-included directories found matching 'build' 16:03:50 INFO - no previously-included directories found matching 'dist' 16:03:50 INFO - no previously-included directories found matching '.git*' 16:03:50 INFO - Successfully installed jsonschema functools32 16:03:50 INFO - Cleaning up... 16:03:50 INFO - Return code: 0 16:03:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x154a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5290>, '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 0x17e5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6040>, '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': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', '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 16:03:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:03:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:03:50 INFO - Using env: {'DISPLAY': ':0', 16:03:50 INFO - 'HOME': '/home/cltbld', 16:03:50 INFO - 'LANG': 'en_US.UTF-8', 16:03:50 INFO - 'LANGUAGE': 'en_US:en', 16:03:50 INFO - 'LOGNAME': 'cltbld', 16:03:50 INFO - 'MAIL': '/var/mail/cltbld', 16:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:50 INFO - 'MOZ_NO_REMOTE': '1', 16:03:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:50 INFO - 'NO_EM_RESTART': '1', 16:03:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:50 INFO - 'PWD': '/builds/slave/test', 16:03:50 INFO - 'SHELL': '/bin/bash', 16:03:50 INFO - 'SHLVL': '1', 16:03:50 INFO - 'TERM': 'linux', 16:03:50 INFO - 'TMOUT': '86400', 16:03:50 INFO - 'USER': 'cltbld', 16:03:50 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', 16:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:50 INFO - '_': '/tools/buildbot/bin/python'} 16:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:03:51 INFO - Cleaning up... 16:03:51 INFO - Return code: 0 16:03:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:51 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 0x154a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5290>, '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 0x17e5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6040>, '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': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', '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 16:03:51 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 16:03:51 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 16:03:51 INFO - Using env: {'DISPLAY': ':0', 16:03:51 INFO - 'HOME': '/home/cltbld', 16:03:51 INFO - 'LANG': 'en_US.UTF-8', 16:03:51 INFO - 'LANGUAGE': 'en_US:en', 16:03:51 INFO - 'LOGNAME': 'cltbld', 16:03:51 INFO - 'MAIL': '/var/mail/cltbld', 16:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:51 INFO - 'MOZ_NO_REMOTE': '1', 16:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:51 INFO - 'NO_EM_RESTART': '1', 16:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:51 INFO - 'PWD': '/builds/slave/test', 16:03:51 INFO - 'SHELL': '/bin/bash', 16:03:51 INFO - 'SHLVL': '1', 16:03:51 INFO - 'TERM': 'linux', 16:03:51 INFO - 'TMOUT': '86400', 16:03:51 INFO - 'USER': 'cltbld', 16:03:51 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', 16:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:51 INFO - '_': '/tools/buildbot/bin/python'} 16:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:51 INFO - Downloading/unpacking blobuploader==1.2.4 16:03:51 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 16:03:51 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 16:03:51 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 16:03:51 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 16:03:51 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 16:03:51 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 16:03:53 INFO - Downloading blobuploader-1.2.4.tar.gz 16:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:03:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:03:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:03:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:03:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:03:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:03:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:03:54 INFO - Downloading docopt-0.6.1.tar.gz 16:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:03:54 INFO - Installing collected packages: blobuploader, requests, docopt 16:03:54 INFO - Running setup.py install for blobuploader 16:03:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:03:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:03:54 INFO - Running setup.py install for requests 16:03:54 INFO - Running setup.py install for docopt 16:03:54 INFO - Successfully installed blobuploader requests docopt 16:03:54 INFO - Cleaning up... 16:03:54 INFO - Return code: 0 16:03:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:03:54 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')]} 16:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:54 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')]} 16:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:54 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 0x154a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5290>, '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 0x17e5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6040>, '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': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', '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 16:03:54 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 16:03:54 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 16:03:54 INFO - Using env: {'DISPLAY': ':0', 16:03:54 INFO - 'HOME': '/home/cltbld', 16:03:54 INFO - 'LANG': 'en_US.UTF-8', 16:03:54 INFO - 'LANGUAGE': 'en_US:en', 16:03:54 INFO - 'LOGNAME': 'cltbld', 16:03:54 INFO - 'MAIL': '/var/mail/cltbld', 16:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:54 INFO - 'MOZ_NO_REMOTE': '1', 16:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:54 INFO - 'NO_EM_RESTART': '1', 16:03:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:54 INFO - 'PWD': '/builds/slave/test', 16:03:54 INFO - 'SHELL': '/bin/bash', 16:03:54 INFO - 'SHLVL': '1', 16:03:54 INFO - 'TERM': 'linux', 16:03:54 INFO - 'TMOUT': '86400', 16:03:54 INFO - 'USER': 'cltbld', 16:03:54 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', 16:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:54 INFO - '_': '/tools/buildbot/bin/python'} 16:03:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:03:54 INFO - Running setup.py (path:/tmp/pip-sN36TW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:03:55 INFO - Running setup.py (path:/tmp/pip-dyy7qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:03:55 INFO - Running setup.py (path:/tmp/pip-qtGwAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:03:55 INFO - Running setup.py (path:/tmp/pip-NyqYdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:03:55 INFO - Running setup.py (path:/tmp/pip-XnwrEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:03:55 INFO - Running setup.py (path:/tmp/pip-Obhq01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:03:55 INFO - Running setup.py (path:/tmp/pip-tczyDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:03:55 INFO - Running setup.py (path:/tmp/pip-GvrbPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:03:55 INFO - Running setup.py (path:/tmp/pip-b8hG_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:03:55 INFO - Running setup.py (path:/tmp/pip-oBg1kR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:03:55 INFO - Running setup.py (path:/tmp/pip-0fOPNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:03:55 INFO - Running setup.py (path:/tmp/pip-BDA4Zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:03:55 INFO - Running setup.py (path:/tmp/pip-HJ17zQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:03:55 INFO - Running setup.py (path:/tmp/pip-bGk4ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:03:55 INFO - Running setup.py (path:/tmp/pip-x6vU8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:03:56 INFO - Running setup.py (path:/tmp/pip-PJPGVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:03:56 INFO - Running setup.py (path:/tmp/pip-YGoNPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:03:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:03:56 INFO - Running setup.py install for manifestparser 16:03:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:03:56 INFO - Running setup.py install for mozcrash 16:03:56 INFO - Running setup.py install for mozdebug 16:03:56 INFO - Running setup.py install for mozdevice 16:03:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:03:56 INFO - Running setup.py install for mozfile 16:03:56 INFO - Running setup.py install for mozhttpd 16:03:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:03:56 INFO - Running setup.py install for mozinfo 16:03:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:03:56 INFO - Running setup.py install for mozInstall 16:03:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:03:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:03:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:03:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:03:57 INFO - Running setup.py install for mozleak 16:03:57 INFO - Running setup.py install for mozlog 16:03:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:03:57 INFO - Running setup.py install for moznetwork 16:03:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:03:57 INFO - Running setup.py install for mozprocess 16:03:57 INFO - Running setup.py install for mozprofile 16:03:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:03:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:03:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:03:57 INFO - Running setup.py install for mozrunner 16:03:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:03:57 INFO - Running setup.py install for mozscreenshot 16:03:57 INFO - Running setup.py install for moztest 16:03:57 INFO - Running setup.py install for mozversion 16:03:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:03:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:03:58 INFO - Cleaning up... 16:03:58 INFO - Return code: 0 16:03:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:03:58 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')]} 16:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:58 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')]} 16:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:58 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 0x154a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5290>, '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 0x17e5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6040>, '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': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', '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 16:03:58 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 16:03:58 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 16:03:58 INFO - Using env: {'DISPLAY': ':0', 16:03:58 INFO - 'HOME': '/home/cltbld', 16:03:58 INFO - 'LANG': 'en_US.UTF-8', 16:03:58 INFO - 'LANGUAGE': 'en_US:en', 16:03:58 INFO - 'LOGNAME': 'cltbld', 16:03:58 INFO - 'MAIL': '/var/mail/cltbld', 16:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:58 INFO - 'MOZ_NO_REMOTE': '1', 16:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:58 INFO - 'NO_EM_RESTART': '1', 16:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:58 INFO - 'PWD': '/builds/slave/test', 16:03:58 INFO - 'SHELL': '/bin/bash', 16:03:58 INFO - 'SHLVL': '1', 16:03:58 INFO - 'TERM': 'linux', 16:03:58 INFO - 'TMOUT': '86400', 16:03:58 INFO - 'USER': 'cltbld', 16:03:58 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', 16:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:58 INFO - '_': '/tools/buildbot/bin/python'} 16:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:03:58 INFO - Running setup.py (path:/tmp/pip-CM6YsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:03:58 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)) 16:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:03:58 INFO - Running setup.py (path:/tmp/pip-hsdBhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:03:58 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)) 16:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:03:58 INFO - Running setup.py (path:/tmp/pip-XFUdrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:03:58 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)) 16:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:03:58 INFO - Running setup.py (path:/tmp/pip-7inC17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:03:58 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)) 16:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:03:58 INFO - Running setup.py (path:/tmp/pip-39WCQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:03:58 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)) 16:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:03:58 INFO - Running setup.py (path:/tmp/pip-7E8LyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:03:58 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)) 16:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:03:58 INFO - Running setup.py (path:/tmp/pip-qbOMdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:03:58 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)) 16:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:03:58 INFO - Running setup.py (path:/tmp/pip-o71pzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:03:58 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)) 16:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:03:58 INFO - Running setup.py (path:/tmp/pip-alu8oA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:03:58 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)) 16:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:03:58 INFO - Running setup.py (path:/tmp/pip-l18Wny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:03:58 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)) 16:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:03:58 INFO - Running setup.py (path:/tmp/pip-FItDu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:03:59 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)) 16:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:03:59 INFO - Running setup.py (path:/tmp/pip-8Ys4WU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 16:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:03:59 INFO - Running setup.py (path:/tmp/pip-LUS_ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:03:59 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)) 16:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:03:59 INFO - Running setup.py (path:/tmp/pip-7JMg8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:03:59 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)) 16:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:03:59 INFO - Running setup.py (path:/tmp/pip-pz_i_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:03:59 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)) 16:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:03:59 INFO - Running setup.py (path:/tmp/pip-04AQof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:03:59 INFO - Running setup.py (path:/tmp/pip-PHwtjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:03:59 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)) 16:03:59 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)) 16:03:59 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)) 16:03:59 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)) 16:03:59 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)) 16:03:59 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)) 16:03:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:03:59 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 16:03:59 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 16:03:59 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 16:03:59 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 16:03:59 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 16:03:59 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 16:04:01 INFO - Downloading blessings-1.6.tar.gz 16:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:04:01 INFO - Installing collected packages: blessings 16:04:01 INFO - Running setup.py install for blessings 16:04:01 INFO - Successfully installed blessings 16:04:01 INFO - Cleaning up... 16:04:01 INFO - Return code: 0 16:04:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:04:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:04:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:04:02 INFO - Reading from file tmpfile_stdout 16:04:02 INFO - Current package versions: 16:04:02 INFO - argparse == 1.2.1 16:04:02 INFO - blessings == 1.6 16:04:02 INFO - blobuploader == 1.2.4 16:04:02 INFO - docopt == 0.6.1 16:04:02 INFO - functools32 == 3.2.3-2 16:04:02 INFO - jsonschema == 2.5.1 16:04:02 INFO - manifestparser == 1.1 16:04:02 INFO - mozInstall == 1.12 16:04:02 INFO - mozcrash == 1.0 16:04:02 INFO - mozdebug == 0.1 16:04:02 INFO - mozdevice == 0.49 16:04:02 INFO - mozfile == 1.2 16:04:02 INFO - mozhttpd == 0.7 16:04:02 INFO - mozinfo == 0.9 16:04:02 INFO - mozleak == 0.1 16:04:02 INFO - mozlog == 3.4 16:04:02 INFO - moznetwork == 0.27 16:04:02 INFO - mozprocess == 0.25 16:04:02 INFO - mozprofile == 0.28 16:04:02 INFO - mozrunner == 6.13 16:04:02 INFO - mozscreenshot == 0.1 16:04:02 INFO - mozsystemmonitor == 0.3 16:04:02 INFO - moztest == 0.8 16:04:02 INFO - mozversion == 1.4 16:04:02 INFO - psutil == 3.1.1 16:04:02 INFO - requests == 1.2.3 16:04:02 INFO - wsgiref == 0.1.2 16:04:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:04: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')]} 16:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04: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')]} 16:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:02 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 0x154a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5290>, '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 0x17e5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6040>, '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': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', '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 16:04:02 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 16:04:02 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 16:04:02 INFO - Using env: {'DISPLAY': ':0', 16:04:02 INFO - 'HOME': '/home/cltbld', 16:04:02 INFO - 'LANG': 'en_US.UTF-8', 16:04:02 INFO - 'LANGUAGE': 'en_US:en', 16:04:02 INFO - 'LOGNAME': 'cltbld', 16:04:02 INFO - 'MAIL': '/var/mail/cltbld', 16:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:02 INFO - 'MOZ_NO_REMOTE': '1', 16:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:02 INFO - 'NO_EM_RESTART': '1', 16:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:02 INFO - 'PWD': '/builds/slave/test', 16:04:02 INFO - 'SHELL': '/bin/bash', 16:04:02 INFO - 'SHLVL': '1', 16:04:02 INFO - 'TERM': 'linux', 16:04:02 INFO - 'TMOUT': '86400', 16:04:02 INFO - 'USER': 'cltbld', 16:04:02 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', 16:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:02 INFO - '_': '/tools/buildbot/bin/python'} 16:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:02 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)) 16:04:02 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)) 16:04:02 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)) 16:04:02 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)) 16:04:02 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)) 16:04:02 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)) 16:04:02 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)) 16:04:02 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)) 16:04:02 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)) 16:04:02 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)) 16:04:02 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)) 16:04:02 INFO - Cleaning up... 16:04:02 INFO - Return code: 0 16:04:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:04: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')]} 16:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04: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')]} 16:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5290>, '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 0x17e5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6040>, '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': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', '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 16:04: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'] in /builds/slave/test/build 16:04: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 16:04:02 INFO - Using env: {'DISPLAY': ':0', 16:04:02 INFO - 'HOME': '/home/cltbld', 16:04:02 INFO - 'LANG': 'en_US.UTF-8', 16:04:02 INFO - 'LANGUAGE': 'en_US:en', 16:04:02 INFO - 'LOGNAME': 'cltbld', 16:04:02 INFO - 'MAIL': '/var/mail/cltbld', 16:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:02 INFO - 'MOZ_NO_REMOTE': '1', 16:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:02 INFO - 'NO_EM_RESTART': '1', 16:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:02 INFO - 'PWD': '/builds/slave/test', 16:04:02 INFO - 'SHELL': '/bin/bash', 16:04:02 INFO - 'SHLVL': '1', 16:04:02 INFO - 'TERM': 'linux', 16:04:02 INFO - 'TMOUT': '86400', 16:04:02 INFO - 'USER': 'cltbld', 16:04:02 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', 16:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:02 INFO - '_': '/tools/buildbot/bin/python'} 16:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:04:02 INFO - Cleaning up... 16:04:02 INFO - Return code: 0 16:04:02 INFO - Running post-action listener: _resource_record_post_action 16:04:02 INFO - Running post-action listener: _start_resource_monitoring 16:04:02 INFO - Starting resource monitoring. 16:04:02 INFO - [mozharness: 2017-03-25 23:04:02.634832Z] Finished create-virtualenv step (success) 16:04:02 INFO - [mozharness: 2017-03-25 23:04:02.635341Z] Running install step. 16:04:02 INFO - Running pre-action listener: _resource_record_pre_action 16:04:02 INFO - Running main action method: install 16:04:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:04:02 INFO - Reading from file tmpfile_stdout 16:04:02 INFO - Detecting whether we're running mozinstall >=1.0... 16:04:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:04:02 INFO - Reading from file tmpfile_stdout 16:04:02 INFO - Output received: 16:04:02 INFO - Usage: mozinstall [options] installer 16:04:02 INFO - Options: 16:04:02 INFO - -h, --help show this help message and exit 16:04:02 INFO - -d DEST, --destination=DEST 16:04:02 INFO - Directory to install application into. [default: 16:04:02 INFO - "/builds/slave/test"] 16:04:02 INFO - --app=APP Application being installed. [default: firefox] 16:04:02 INFO - mkdir: /builds/slave/test/build/application 16:04:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:04:18 INFO - Reading from file tmpfile_stdout 16:04:18 INFO - Output received: 16:04:18 INFO - /builds/slave/test/build/application/firefox/firefox 16:04:18 INFO - Running post-action listener: _resource_record_post_action 16:04:18 INFO - [mozharness: 2017-03-25 23:04:18.640146Z] Finished install step (success) 16:04:18 INFO - [mozharness: 2017-03-25 23:04:18.640418Z] Running run-tests step. 16:04:18 INFO - Running pre-action listener: _resource_record_pre_action 16:04:18 INFO - Running main action method: run_tests 16:04:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:04:18 INFO - Python 2.7.3 16:04:18 INFO - Return code: 0 16:04:18 INFO - grabbing minidump binary from tooltool 16:04:18 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')]} 16:04:18 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 0x17e5290>, '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 0x17e5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:04:18 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 16:04:18 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 16:04:18 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 16:04:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:04:18 INFO - Return code: 0 16:04:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:04:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:04:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:04:18 INFO - ENV: RUST_BACKTRACE is now 1 16:04:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:04:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:04:18 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/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 16:04:18 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/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 16:04:18 INFO - Using env: {'DISPLAY': ':0', 16:04:18 INFO - 'HOME': '/home/cltbld', 16:04:18 INFO - 'LANG': 'en_US.UTF-8', 16:04:18 INFO - 'LANGUAGE': 'en_US:en', 16:04:18 INFO - 'LOGNAME': 'cltbld', 16:04:18 INFO - 'MAIL': '/var/mail/cltbld', 16:04:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:04:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:18 INFO - 'MOZ_NO_REMOTE': '1', 16:04:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:18 INFO - 'NO_EM_RESTART': '1', 16:04:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:18 INFO - 'PWD': '/builds/slave/test', 16:04:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:04:18 INFO - 'RUST_BACKTRACE': '1', 16:04:18 INFO - 'SHELL': '/bin/bash', 16:04:18 INFO - 'SHLVL': '1', 16:04:18 INFO - 'TERM': 'linux', 16:04:18 INFO - 'TMOUT': '86400', 16:04:18 INFO - 'USER': 'cltbld', 16:04:18 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490480327.798592-1876497116', 16:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:18 INFO - '_': '/tools/buildbot/bin/python'} 16:04:18 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/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 16:04:18 INFO - mozversion application_buildid: 20170325223310 16:04:18 INFO - mozversion application_changeset: 2ecf610d3185de940cb7b4ed2c214dc9e2367cee 16:04:18 INFO - mozversion application_display_name: Nightly 16:04:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:04:18 INFO - mozversion application_name: Firefox 16:04:18 INFO - mozversion application_remotingname: firefox 16:04:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:04:18 INFO - mozversion application_vendor: Mozilla 16:04:18 INFO - mozversion application_version: 55.0a1 16:04:18 INFO - mozversion platform_buildid: 20170325223310 16:04:18 INFO - mozversion platform_changeset: 2ecf610d3185de940cb7b4ed2c214dc9e2367cee 16:04:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:04:18 INFO - mozversion platform_version: 55.0a1 16:04:18 INFO - using testdate: 1490483058 16:04:18 INFO - actual date: 1490483058 16:04:18 INFO - starting webserver on 'localhost:53199' 16:04:18 INFO - SUITE-START | Running 2 tests 16:04:18 INFO - TEST-START | dromaeo_css 16:04:18 INFO - operating with platform_type : linux_ 16:04:18 INFO - Initialising browser for dromaeo_css test... 16:04:18 INFO - TEST-INFO | started process 12745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeJdmmf/profile http://localhost:53199/getInfo.html) 16:04:23 INFO - PID 12745 | __metrics Screen width/height:1600/1200 16:04:23 INFO - PID 12745 | colorDepth:24 16:04:23 INFO - PID 12745 | Browser inner width/height: 1024/697 16:04:23 INFO - PID 12745 | __metrics 16:04:24 INFO - PID 12745 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:04:24 INFO - PID 12745 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:04:25 INFO - TEST-INFO | 12745: exit 0 16:04:25 INFO - Browser initialized. 16:04:25 INFO - Running cycle 1/1 for dromaeo_css test... 16:04:25 INFO - TEST-INFO | started process 12838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeJdmmf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:04:37 INFO - PID 12838 | RSS: Main: 149815296 16:04:37 INFO - PID 12838 | 16:07:43 INFO - PID 12838 | Cycle 1(1): loaded http://localhost:53199/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53199/tests/dromaeo/cssquery-ext.html) 16:07:45 INFO - PID 12838 | RSS: Main: 313073664 16:07:45 INFO - PID 12838 | 16:09:27 INFO - PID 12838 | ************************* 16:09:27 INFO - PID 12838 | A coding exception was thrown and uncaught in a Task. 16:09:27 INFO - PID 12838 | 16:09:27 ERROR - PID 12838 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:09:27 INFO - PID 12838 | Full stack: 16:09:27 INFO - PID 12838 | ************************* 16:10:48 INFO - PID 12838 | Cycle 1(1): loaded http://localhost:53199/tests/dromaeo/cssquery-ext.html (next: http://localhost:53199/tests/dromaeo/cssquery-jquery.html) 16:10:48 INFO - PID 12838 | RSS: Main: 241950720 16:10:48 INFO - PID 12838 | 16:13:51 INFO - PID 12838 | Cycle 1(1): loaded http://localhost:53199/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53199/tests/dromaeo/cssquery-mootools.html) 16:13:51 INFO - PID 12838 | RSS: Main: 179879936 16:13:51 INFO - PID 12838 | 16:16:53 INFO - PID 12838 | Cycle 1(1): loaded http://localhost:53199/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53199/tests/dromaeo/cssquery-prototype.html) 16:16:54 INFO - PID 12838 | RSS: Main: 196452352 16:16:54 INFO - PID 12838 | 16:19:57 INFO - PID 12838 | Cycle 1(1): loaded http://localhost:53199/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53199/tests/dromaeo/cssquery-yui.html) 16:19:58 INFO - PID 12838 | RSS: Main: 187400192 16:19:58 INFO - PID 12838 | 16:23:01 INFO - PID 12838 | Cycle 1(1): loaded http://localhost:53199/tests/dromaeo/cssquery-yui.html (next: http://localhost:53199/tests/dromaeo/cssquery-dojo.html) 16:23:01 INFO - PID 12838 | RSS: Main: 275755008 16:23:01 INFO - PID 12838 | 16:23:01 INFO - PID 12838 | __start_tp_report 16:23:01 INFO - PID 12838 | _x_x_mozilla_page_load 16:23:01 INFO - PID 12838 | _x_x_mozilla_page_load_details 16:23:01 INFO - PID 12838 | |i|pagename|runs| 16:23:01 INFO - PID 12838 | |0;dojo.html;2664.973350266497;2693.1247344613007;2727.1000569811963;2733.2893447703605;2734.863256837158;5101.285819985205;5223.791048358061;5228.6078544109205;5268.8155914542995;5311.73441327934;5176.50823171799;5185.766640501177;5209.453007434222;5210.713410762407;5211.478852114787;4730.385049943503;4758.904821903559;4782.521747825224;4782.83260085897;4827.227643577028;4787.976060119695;4805.663603547753;4808.807647694106;4824.517548245182;4829.227323628203;4807.78364973577;4815.759212039402;4820.855374338776;4827.275908613701;4873.585745211643;4826.662133650646;4831.637627177958;4831.855044348676;4873.122837889178;4879.365682461293;4752.9762351188365;4762.047590481883;4764.6426518011285;4786.593139583139;4822.95177048232;5250.579953603703;5267;5276.709780962045;5315.176147697113;5315.73421328932;5582.692951887645;5624.043912534838;5634.295713035871;5636.71816409182;5689.203511508392;4573.49691533931;5563.109902415635;5625.268715067015;5730.025895597759;5730.856728581819;5257.342832145981;5260.684358938438;5265.420803711589;5268.025415298182;5312.73436328182;5813.476787089182;5817.0401883689565;5824.767009319579;5827.79602713903;5828.0966450200285;5412.242286079952;5464.672119672832;5473.507384335349;5480.3971563128025;5587.720613969285;5622.24099746529;5638.35158956717;5644.294463192101;5699.401562835843;5707.828765137053;5575.0522411190195;5583.106702927512;5594.916076258859;5595.076812326002;5595.63628364155;5461.699606521679;5532.695701736363;5588.497035266845;5589.049861523551;5594.13290939905;4609.446866376056;4665.2768820832825;4675.509071547506;4695.882602934886;4696.600788932979;4009.0578714002186;4012.2376748417705;4012.9799351003057;4016.738911970771;4030.435738996543;4762.59517940972;4765;4778.068276686083;4780.211265141213;4811;5513.641613295123;5517.475839795213;5572.359178694421;5579.8884022320135;5660.462256085665;4718.646101542398;4733.739644319596;4767.165745994437;4773.71357718538;4782.976085119552;4938.506149385104;4943.332650092263;4966.230234313687;4969.453360130383;5014.2979982802435;5122.052420302256;5239.764210610531;5241.764120614505;5241.921371179512;5245.263236725799;5557.944420555905;5590.468905453975;5615.241942337732;5625.746841392229;5669.971650141723;5190.221466779863;5247.1866860636665;5258.316418865523;5266.578673706018;5286.392064912584;5528.06022976087;5552.167174923794;5556.083246264321;5558.471945165203;5618.157276408571;5500.257465242301;5510.090835012178;5565.7217139143695;5635.577331700221;5637.661740295595;5406.675599463887;5416.647917885325;5420.4850539198715;5420.83737487876;5422.810201642924;5391.865203369947;5485.61600687948;5514.420985796433;5524.1989911463415;5535.114381698909;5385;5394.676319420847;5410.864728381822;5427.3215848019;5430.429804870431;5500.1749737539685;5510.712506228201;5514.228008078952;5526.86182845416;5560.277163968658;5187;5237.895242095061;5242.633015688865;5245.082110630548;5253.290805741329 16:23:01 INFO - PID 12838 | |1;ext.html;645.9612423254605;709.7161135545782;731.7182884589434;1056.7146870345011;1077.1490522487236;24417;29668.851655741717;30280.091597252063;30324.84837575809;30488.695113048892;32056.519152212677;32341.191470213256;32390;32460;32467.675323246818;5526.171074338861;5681.233033540481;7133.999999999987;7251.16611589666;7301.598412087333;7136.072310599615;7293.307135822089;7297.343239108479;7319.304666056716;7321.926780732178;7341.743038993636;7438.479306448551;7440.367568756662;7570.31867131958;7579.052618422697;7474.028376311072;7524.623768811538;7536.924630753704;7537.773866784005;7540.132884718273;7396.815079622998;7435.7397491088095;7448.106227252711;7452.813679657997;7460.14208366034;32438.189045273823;32549.6745032549;32625.02124936256;32640.183995400068;32642;2499.713678214154;2514;2515.8364706294033;2529.481456301454;2580.1485509781915;23228.187013454615;23344.299671009896;23762.762372376226;23980.880095599583;24064;2576.2142546523305;2611.9347016324555;2616.2543675052707;2632.4866651003063;2647.470505898828;152233;152540;152903;153361.23319383332;153502;41718.37422438666;41748.79125604353;41775.1644967099;41781.37327940023;41806.581934180875;44051;44079.77960110179;44128.3380749289;44183.77908110503;44209.557904421185;12925.612231633066;13189.142705724098;13192.538261160813;13222.603321900358;13251.072424930355;9089.545522723838;9236.214921731593;9655.855162172573;10709.78580428387;10772.89227107719;11708.590199342982;11732.178747487595;11743.354115523729;11757.764844703059;11917.821232681517;4890.481402077933;4945.67853089548;4992.301077849104;5008.424031236382;5081.161608334657;855.1363123245567;883.5673408806832;891.6522556203086;898.9146031127033;924.8381533231658;19854.70217946732;20629;20711.68932465984;20743.58512829735;21167.364979050653;918.911090357928;947.3984020147257;965.4255717847869;974.8732664753537;975;10665.146788256921;11138.83042280549;11233.775324493465;11286.07364271985;11288;213488;214085;214100;214622;215132;41076.1784764303;41180.79409602933;41261.174776504304;41262.38106428406;41283.380749288786;1196.419736427849;1234.2902830872285;1243.570968016033;1246.2709315050615;1250.9061820363509;18670.90664546723;18763.437096887115;19608.8039119607;19796.50508737293;19877.701834472206;29782.851085744434;29905.70094299029;30039.249018774706;30043.3991320168;30057.54913676253;219859;220265;220836;221273;221723;21347.25284615031;21558.353249402542;21567.2451464198;28390.290242744097;28577;23668.52662946697;25040.248792535524;29457.558136628395;30261.697383026767;30268.394632107676;22210.77789222087;22630.094796208625;23496.647550286416;24075.51848963046;25016.37459063538;23696.644550331413;24266;24372.756272437047;24620.753792461845;24835.62746558767;27225;27449.725502745518;27872.581911270943;27938.58092128579;27956.86021569879;23551.764482355644;24135.879320603988;24149;24200;24638.630420543348;19315.90342048281;20318.59362812706;20510.589788204452;20584.176632935112;20614 16:23:01 INFO - PID 12838 | |2;jquery.html;411.1325104030493;419.8278705730651;430.3566168577975;435.7929983257953;440.64748201438863;12148.635540933765;16482.340706371746;17151.656966860653;17211.65576688467;17307.82692173078;13449.32753362333;13495;17015.82984170158;17471.82528174718;17694.734578981326;5486.149646804752;5519.337679478458;5678.659280443187;5715.799947001856;5716.7141642917895;5638.859028524299;5687.061634830268;5689.544836413077;5693.430656934315;5694.5159661428825;5397.163439666858;5573.359063707685;5599.860003499904;5600.1599760035915;5609.298837645294;5512.862178445571;5542.168674698787;5577.9163312550345;5622.072358060915;5623.943760562423;5111.872203194913;5150.459201783834;5156.381234251914;5156.819511317086;5163.406208286057;22009;22277.331680049625;22281.66577501339;22322.88838555797;22368.77631223683;1536.60816491795;1540.2606748760545;1542.8611424971693;1584.952451426459;1591.6737068900964;13316.201027938354;13926;13972.93013534936;14082.859171408258;14486.927565362106;1688.4512533426685;1694.847463728258;1706.5733566608349;1721.1652348610914;1755.782935860174;86588;89084.55457722735;90676.09323906743;90985.09014909832;91623.54188229083;10515.263931524873;10681.626143084955;10762.24664273509;10865.130789536817;11005;15399.23003849803;15468.381264749509;15523.301451434487;15545.455909043128;15547.300371483085;6786.558873673195;7102.4318054555515;7549.660265288076;7844.657106798289;8003.439759216799;7019.192792828788;7284.599347035964;7286.635668216568;7326.853462930711;7338.853222935511;6841.247462779091;6885.655717214119;6956.912926122143;6964.268751781091;6967.965160174268;2041.5610643711673;2051.056514003545;2057.79422057796;2071.5856828634332;2143.389134096775;833.4832403909494;846.8856704344958;847.5338563789891;866.8873046503915;877.7015814623059;15944.362225511082;16441.424550140688;16853.578660533338;17101.828981710274;17143.74284385735;863.4646519158163;870.4820631724114;871.3639043498155;878.8462019146624;894.4856707393145;8503.659853605786;9175.678851240174;9233.676821311223;9322.720318390458;9430.10414010668;387375;391746;399342;425060;425430;65603.34396656067;87830;88392;88943.55528222317;91960.0803991965;1090.5310716392028;1130.7851508213414;1134.1720544002924;1145.977080458403;1146.358039497884;17062.402815901383;17254.741178882578;17730.290788368322;17742;17849.553761156076;37805;37904.810475947445;38692.6130738689;44106.11787764291;46118;45682;45738;48583.75708121437;54593.727031364586;54998.72500637471;5219.422493911743;6828.317168283132;7630.465867389229;7643.235676432535;7886.802829929297;11168.832467512831;11236.157288203582;11333.886661133283;11464.426778660867;11763;9528.52357382142;9863.704088877344;9884.654037108667;9953.751156221153;10077.19382449417;8624.698135565224;9027.322950778587;9071.319651026331;9107.408018478778;9126.083522460358;9091.136342047495;9462.432254064779;9685;9716.514174291116;10198.439085850052;7562.848743024999;7659.731909383145;7804.102528209101;7815;7824.491408058458;9582.808343832945;9621.134097931219;9744.171745401436;9782.217422606032;10279.331843430153 16:23:01 INFO - PID 12838 | |3;mootools.html;1213.939303034848;1269.3653173413293;1281.2120545864295;1289.3553223388305;1290.7805673035582;9432.339736218468;9804.55879485423;9823.066808653175;9825.950870245639;9826.066523680256;9447.905520944789;9931;9938;9938.105570498654;9945.05521975413;2190.310052333518;2232.408411770882;2235.0724449353497;2235.2623634200677;2238.250186187629;1833.0926191535143;2139.2940329691164;2226.3988723044768;2234.6759719840616;2237.7090978172896;1899.2782742557808;2143.7749036351192;2204.1403852497538;2221.4779526811185;2229.3534874886263;2150.9462263443384;2160.8811515366647;2167.8048975592114;2170.7612162662094;2179.5422961178174;2139.208492857637;2146.034284571949;2147.8281737460966;2148.419926619804;2149.9355019349446;9793.804123917482;10040.246981476346;10054.597816087347;10058.547365368502;10062;5356.437574054746;5569;5571.415001424833;5572.693501857396;5573.303337082864;3042.1481985044;3152.1489197916435;3159.936801263962;3190.409774191782;3206.070239630504;929.9302552308604;969.5249327829383;1012.5190534496129;1027.542743479152;1048.3343077145992;14344.856551434457;14489.855101449062;14498.927505362512;14500.347484363228;14519.128852268897;4685.882852928636;4765.237561990134;4778.689385190021;4793.01743142655;4805.471398146201;10929.945350273198;11074.944625276821;11074.944625276821;11075.556977720962;11079.061164296378;5223.451537588575;5229.241759944786;5229.686218826882;5236.92144617831;5239.973800130975;4861.173600487926;4916.336294600254;4955.8513244602;5020.899582008413;5022.397312322545;3632.2917031178667;3743.21392507571;3788.6211378862445;3818.9427158592644;3867.8340129527555;1030.1192480429274;1039.1219419590434;1040.438163391775;1051.4795176387738;1056.3081181825917;578.1068249554448;597.2504506843883;638.9073584330339;660.0495286787011;662.9701663425158;5279.41926388097;5343.251944727741;5367.704776237344;5409.323834520685;5634.267545219095;783.5729527407576;800.2197857089408;805.5005896344304;814.9633266503022;820.5856042698518;3277.524758909945;3287.6547962464074;3302.1249368917256;3476.200473891019;3616.3129005488872;12045.879541204651;12978;12981.805272920914;12997.935010324887;13013;12720.109592328448;12866.806997895039;12938.870611293954;12976.805347919788;12981.221126732426;9319.627214911328;9353.766155846159;9392.765180870396;9393.906060939304;9427.764305892544;5309.707966061904;5315.2064249967725;5403.567714582902;5475.425080366664;5607.719614019201;11312.434378281218;11500.654980350602;11525.88474115248;11662.300261984308;11702.824457632973;11680.182387233152;11747;11771.646850594496;11835.349055802013;11870.228435151688;8186.754397368089;8194.713185038496;8290.046644635944;8372.916270837213;8398.244158025807;9026.638934442812;9037.548122593975;9104.453732776055;9106.134917182857;9119.908800911906;7281.526700764433;7350.228226036403;7350.926490735024;7355.632218389166;7529.058867641545;7469.365103966006;7481.513701609378;7580.886286705814;7608.771736847903;7724.227577242231;6585.242697089896;6836.418904393182;6922.06552115458;6934.93065069363;6946.583205007716;4913.115639184981;4947.876303092451;5008.373953255843;5038.2190760432195;5189.6886186828915;4755.636576776155;4767.284907263938;4778.1638213311835;4981.825636102719;5015.448300686849 16:23:01 INFO - PID 12838 | |4;prototype.html;380.1807105687245;396.8253968253968;402.4647219198466;403.18556515838026;405.81941036238885;5413.296271484702;5430.565554755615;5449.509544141027;5471.470901268679;5474.275603185004;5056.089903817311;5246.842594722155;5251.343582052244;5270.841874743764;5331.680099194051;4143.357779544161;4145.917081658365;4154.709170358076;4158.97920510397;4159.875203743877;4143.212789569987;4149.128682976579;4165.958340416587;4172.228137794503;4181.310083836163;3942.645161935425;4091.284025295576;4098.913787846223;4117.526484454281;4118.011677197466;4088.08018195905;4095.8361665533344;4104.651104656108;4123.443335149746;4124.42258083867;3575.1777091269155;3577.0878426001464;3578.3380074686265;3579.9642003579893;3603.40543810271;4976.925346119811;5204.505571970657;5212.50481204285;5226.895462090737;5228.398734145584;4740.644451666139;4761.333413322138;4761.40482439695;4778.351468743278;4785.425748910118;5613;5620.690862002588;5643.492085712264;5659.490645841894;5676.035074037423;3819.446180303868;3996.900077498057;4008.9799551002056;4012.87317721608;4022;5571.526420254283;5749.3963133871175;5791.884162316772;5820.3888591698105;5941.781335251976;4048.4332193492933;4051.8379264829077;4078.1639763848934;4084.6528045116497;4097.303458412077;4107.116969851496;4110.486189226347;4119.855805046809;4120.670346372283;4145.481814773153;4391.363252328459;4463.598276155161;4563.977180114144;4599.448066232074;4617.58441740245;5583.525400341016;5606.803761868315;5610.915836262459;5638.915416268759;5657.943420565742;1418.2412409360943;1420.5383250443647;1426.0588011912296;1429.0639631041684;1430.3849344781636;928.062656716721;967.8596603492595;969.1471505075489;973.9707808765748;977.3647129365969;4861.343718598015;4862.586680132157;4875.43932447773;4878.487758785347;4887.7556122194455;5782.971085144547;5793.94206057934;5802.603578671791;5805.216295800097;5813.5349172066135;4659.394278743742;4862.465128835825;4916.434610019894;4945.876353091129;4958.380202474691;3080.630324361091;3093.334932989418;3106.4718997770433;3107.673694262115;3115;5188.533032027136;5414.620976531605;5438.864028399322;5446.2647542582035;5454.236406903036;5950.19672344228;5987.221661184019;5992.58051936369;5994.460498555151;5995.070764031495;5419.783208671688;5437.945620543744;5440.945590544123;5455.918161227585;5465.9726701366235;5704.743286552032;5799.333076696234;5828.883422331445;5863.765449381977;5865.208196893364;5744.971275143597;5746.281714785652;5749.108888122348;5764.538836892954;5791.189233507396;5144.331236939323;5158.303629010035;5322.520973112439;5408.972295263888;5414.7021913795115;4036.9394459083724;4060.675145988373;4065.7560546367313;4074.1851629673592;4081.4898137732785;5810.84998550539;5834.970825145847;5837.620554664103;5844.6493210405815;5859.648421094748;5451.974154344377;5607.383187849415;5624.7187640616985;5632.436756324335;5655.7172141393585;5604.982206405609;5608;5616.129499927518;5630.7466164023535;5644.576656750843;5396.460353964572;5563.916541251965;5565.77736890536;5568.387477377566;5569.832905012856;5648.926703926241;5658.009848276452;5682.005649011489;5690.71546422669;5707.600467967202;5476.288082549243;5500.734830988815;5504.697241651747;5520.337559492887;5526.286851076179 16:23:01 INFO - PID 12838 | |5;yui.html;686.9089099054256;694.6630884021246;700.2297472779941;700.8528209076094;703.2334755116923;11685.182037257395;12103.636890893287;12147.088968327389;12183.025357971352;12191.817122743154;12860.742785144315;13084.869151308483;14405.78391324131;15009.474668386609;15149.848501514982;850.2305413600686;868.3053557154283;869.9608517616691;871.020102384817;871.4509858788986;830.7839961609994;853.1298075962515;864.1660797330575;864.6930339729399;864.7924498120437;899.9370044096916;903.8373092843285;904.3036861616552;905.302916754099;905.5879574793486;896.3904544909459;897.8294124116462;898.3262553085186;899.4827973914993;900.1043961258524;665.8668266346701;666.6500087454077;667.546068673302;667.629465646566;668.3283300283233;14294.92852535741;14390.568282951528;14555.417783288656;14569.198694071822;14704.191269480174;13024;13423.597292081253;13829.930850345683;13873.4450621975;13966.720665586632;10622.893771062345;10920.93161989517;10956.506957186866;11252.66242012741;11364.863513648652;2651.6950550686724;2662.1305971444676;2666.186813022047;2713.5386984212732;2774.7780177585746;64550.67724661394;64616.3538364615;64788.67605661989;65198.674006630135;65992.67003664999;10213.489325533694;10344.793104137874;10371.844422333672;10475.109615682752;10606.787864242671;21452.89273553622;21453.249136280156;21456.141754329965;21492.14031438756;21499.78500214978;6461.19235095613;6494.220693516808;6528.183977002875;6742.561733487406;6792.490563207779;3195.504696772004;3222.9194270142966;3253.072874230833;3261.0542942546394;3307.015790525665;3555.4311310190765;3555.6266592007983;3581.3732596795458;3584.175639602906;3590.8743193988084;666.6799936030733;672.5527524196452;677.5697432130534;693.5873155472486;696.4602433114276;541.8834950485585;543.1174341694746;555.1672491263105;565.4289167940327;566.6741623566465;7754.651040703182;7868.685252589832;8081.515109093473;8465.365097617703;8524.8721269181;532.5226272440967;539.3312292757031;548.0737553534514;554.5729788063169;562.5780664501624;3640.672339489459;3719.5350581177354;3799.639034291738;3823.9426408603895;3827.3684842000757;63578.68210658917;64986.35013649803;65133.67433162804;65997.34002660008;67452.32547674558;55190;55861.72069139628;56218.820918352634;58900.7054964731;59040;45775.542244577126;50867.745661272194;51065.97868042618;51427.742861286206;53058.73470632622;7522.360599348897;7569.1295501018085;7608.16310205888;7676.462647614613;7760.961195193988;26655.200343989713;27130.457390851676;27605.44789104247;27905.58141627918;27937;33271.16822079467;33611.663883361834;33721.49417758785;33743.4938475928;35037.47443788294;9660.275479338938;9969.451680157661;10065.345752526062;10101.292909496266;10124.797504049731;10500.264981451224;10550.208734344802;10593.89406105929;10598.970635769103;10982.231243812856;9823.656172033945;9910.35582687123;10026.097651211427;10040.447775372424;10168.644097456554;9843.458609776531;10191.847122293024;10229;10265.332753371007;10665.626703065356;9256.120668536478;9381;9479.905200948178;9613.086756758097;9875;6936.930630693629;7140.428765698835;7538.924610753822;7723.845523089394;7746.767596972099;8916.55417229123;9056.13966673165;9098.181163695299;9100.908990910006;9182.908170918472 16:23:01 INFO - PID 12838 | __end_tp_report 16:23:01 INFO - PID 12838 | __start_cc_report 16:23:01 INFO - PID 12838 | _x_x_mozilla_cycle_collect,1841 16:23:01 INFO - PID 12838 | __end_cc_report 16:23:01 INFO - PID 12838 | __startTimestamp1490484181802__endTimestamp 16:23:01 INFO - PID 12838 | 16:23:01 INFO - PID 12838 | ------- Summary: start ------- 16:23:01 INFO - PID 12838 | Number of tests: 6 16:23:01 INFO - PID 12838 | 16:23:01 INFO - PID 12838 | [#0] dojo.html Cycles:165 Average:5150.46 Median:5267.00 stddev:587.08 (11.1%) stddev-sans-first:555.56 16:23:01 INFO - PID 12838 | Values: 2665.0 2693.1 2727.1 2733.3 2734.9 5101.3 5223.8 5228.6 5268.8 5311.7 5176.5 5185.8 5209.5 5210.7 5211.5 4730.4 4758.9 4782.5 4782.8 4827.2 4788.0 4805.7 4808.8 4824.5 4829.2 4807.8 4815.8 4820.9 4827.3 4873.6 4826.7 4831.6 4831.9 4873.1 4879.4 4753.0 4762.0 4764.6 4786.6 4823.0 5250.6 5267.0 5276.7 5315.2 5315.7 5582.7 5624.0 5634.3 5636.7 5689.2 4573.5 5563.1 5625.3 5730.0 5730.9 5257.3 5260.7 5265.4 5268.0 5312.7 5813.5 5817.0 5824.8 5827.8 5828.1 5412.2 5464.7 5473.5 5480.4 5587.7 5622.2 5638.4 5644.3 5699.4 5707.8 5575.1 5583.1 5594.9 5595.1 5595.6 5461.7 5532.7 5588.5 5589.0 5594.1 4609.4 4665.3 4675.5 4695.9 4696.6 4009.1 4012.2 4013.0 4016.7 4030.4 4762.6 4765.0 4778.1 4780.2 4811.0 5513.6 5517.5 5572.4 5579.9 5660.5 4718.6 4733.7 4767.2 4773.7 4783.0 4938.5 4943.3 4966.2 4969.5 5014.3 5122.1 5239.8 5241.8 5241.9 5245.3 5557.9 5590.5 5615.2 5625.7 5670.0 5190.2 5247.2 5258.3 5266.6 5286.4 5528.1 5552.2 5556.1 5558.5 5618.2 5500.3 5510.1 5565.7 5635.6 5637.7 5406.7 5416.6 5420.5 5420.8 5422.8 5391.9 5485.6 5514.4 5524.2 5535.1 5385.0 5394.7 5410.9 5427.3 5430.4 5500.2 5510.7 5514.2 5526.9 5560.3 5187.0 5237.9 5242.6 5245.1 5253.3 16:23:01 INFO - PID 12838 | 16:23:01 INFO - PID 12838 | [#1] ext.html Cycles:180 Average:32525.20 Median:27337.36 stddev:51701.69 (189.1%) stddev-sans-first:51791.32 16:23:01 INFO - PID 12838 | Values: 646.0 709.7 731.7 1056.7 1077.1 24417.0 29668.9 30280.1 30324.8 30488.7 32056.5 32341.2 32390.0 32460.0 32467.7 5526.2 5681.2 7134.0 7251.2 7301.6 7136.1 7293.3 7297.3 7319.3 7321.9 7341.7 7438.5 7440.4 7570.3 7579.1 7474.0 7524.6 7536.9 7537.8 7540.1 7396.8 7435.7 7448.1 7452.8 7460.1 32438.2 32549.7 32625.0 32640.2 32642.0 2499.7 2514.0 2515.8 2529.5 2580.1 23228.2 23344.3 23762.8 23980.9 24064.0 2576.2 2611.9 2616.3 2632.5 2647.5 152233.0 152540.0 152903.0 153361.2 153502.0 41718.4 41748.8 41775.2 41781.4 41806.6 44051.0 44079.8 44128.3 44183.8 44209.6 12925.6 13189.1 13192.5 13222.6 13251.1 9089.5 9236.2 9655.9 10709.8 10772.9 11708.6 11732.2 11743.4 11757.8 11917.8 4890.5 4945.7 4992.3 5008.4 5081.2 855.1 883.6 891.7 898.9 924.8 19854.7 20629.0 20711.7 20743.6 21167.4 918.9 947.4 965.4 974.9 975.0 10665.1 11138.8 11233.8 11286.1 11288.0 213488.0 214085.0 214100.0 214622.0 215132.0 41076.2 41180.8 41261.2 41262.4 41283.4 1196.4 1234.3 1243.6 1246.3 1250.9 18670.9 18763.4 19608.8 19796.5 19877.7 29782.9 29905.7 30039.2 30043.4 30057.5 219859.0 220265.0 220836.0 221273.0 221723.0 21347.3 21558.4 21567.2 28390.3 28577.0 23668.5 25040.2 29457.6 30261.7 30268.4 22210.8 22630.1 23496.6 24075.5 25016.4 23696.6 24266.0 24372.8 24620.8 24835.6 27225.0 27449.7 27872.6 27938.6 27956.9 23551.8 24135.9 24149.0 24200.0 24638.6 19315.9 20318.6 20510.6 20584.2 20614.0 16:23:01 INFO - PID 12838 | 16:23:01 INFO - PID 12838 | [#2] jquery.html Cycles:180 Average:25860.83 Median:5191.41 stddev:67583.82 (1301.8%) stddev-sans-first:67746.40 16:23:01 INFO - PID 12838 | Values: 411.1 419.8 430.4 435.8 440.6 12148.6 16482.3 17151.7 17211.7 17307.8 13449.3 13495.0 17015.8 17471.8 17694.7 5486.1 5519.3 5678.7 5715.8 5716.7 5638.9 5687.1 5689.5 5693.4 5694.5 5397.2 5573.4 5599.9 5600.2 5609.3 5512.9 5542.2 5577.9 5622.1 5623.9 5111.9 5150.5 5156.4 5156.8 5163.4 22009.0 22277.3 22281.7 22322.9 22368.8 1536.6 1540.3 1542.9 1585.0 1591.7 13316.2 13926.0 13972.9 14082.9 14486.9 1688.5 1694.8 1706.6 1721.2 1755.8 86588.0 89084.6 90676.1 90985.1 91623.5 10515.3 10681.6 10762.2 10865.1 11005.0 15399.2 15468.4 15523.3 15545.5 15547.3 6786.6 7102.4 7549.7 7844.7 8003.4 7019.2 7284.6 7286.6 7326.9 7338.9 6841.2 6885.7 6956.9 6964.3 6968.0 2041.6 2051.1 2057.8 2071.6 2143.4 833.5 846.9 847.5 866.9 877.7 15944.4 16441.4 16853.6 17101.8 17143.7 863.5 870.5 871.4 878.8 894.5 8503.7 9175.7 9233.7 9322.7 9430.1 387375.0 391746.0 399342.0 425060.0 425430.0 65603.3 87830.0 88392.0 88943.6 91960.1 1090.5 1130.8 1134.2 1146.0 1146.4 17062.4 17254.7 17730.3 17742.0 17849.6 37805.0 37904.8 38692.6 44106.1 46118.0 45682.0 45738.0 48583.8 54593.7 54998.7 5219.4 6828.3 7630.5 7643.2 7886.8 11168.8 11236.2 11333.9 11464.4 11763.0 9528.5 9863.7 9884.7 9953.8 10077.2 8624.7 9027.3 9071.3 9107.4 9126.1 9091.1 9462.4 9685.0 9716.5 10198.4 7562.8 7659.7 7804.1 7815.0 7824.5 9582.8 9621.1 9744.2 9782.2 10279.3 16:23:01 INFO - PID 12838 | 16:23:01 INFO - PID 12838 | [#3] mootools.html Cycles:180 Average:6103.24 Median:4772.72 stddev:3951.33 (82.8%) stddev-sans-first:3945.34 16:23:01 INFO - PID 12838 | Values: 1213.9 1269.4 1281.2 1289.4 1290.8 9432.3 9804.6 9823.1 9826.0 9826.1 9447.9 9931.0 9938.0 9938.1 9945.1 2190.3 2232.4 2235.1 2235.3 2238.3 1833.1 2139.3 2226.4 2234.7 2237.7 1899.3 2143.8 2204.1 2221.5 2229.4 2150.9 2160.9 2167.8 2170.8 2179.5 2139.2 2146.0 2147.8 2148.4 2149.9 9793.8 10040.2 10054.6 10058.5 10062.0 5356.4 5569.0 5571.4 5572.7 5573.3 3042.1 3152.1 3159.9 3190.4 3206.1 929.9 969.5 1012.5 1027.5 1048.3 14344.9 14489.9 14498.9 14500.3 14519.1 4685.9 4765.2 4778.7 4793.0 4805.5 10929.9 11074.9 11074.9 11075.6 11079.1 5223.5 5229.2 5229.7 5236.9 5240.0 4861.2 4916.3 4955.9 5020.9 5022.4 3632.3 3743.2 3788.6 3818.9 3867.8 1030.1 1039.1 1040.4 1051.5 1056.3 578.1 597.3 638.9 660.0 663.0 5279.4 5343.3 5367.7 5409.3 5634.3 783.6 800.2 805.5 815.0 820.6 3277.5 3287.7 3302.1 3476.2 3616.3 12045.9 12978.0 12981.8 12997.9 13013.0 12720.1 12866.8 12938.9 12976.8 12981.2 9319.6 9353.8 9392.8 9393.9 9427.8 5309.7 5315.2 5403.6 5475.4 5607.7 11312.4 11500.7 11525.9 11662.3 11702.8 11680.2 11747.0 11771.6 11835.3 11870.2 8186.8 8194.7 8290.0 8372.9 8398.2 9026.6 9037.5 9104.5 9106.1 9119.9 7281.5 7350.2 7350.9 7355.6 7529.1 7469.4 7481.5 7580.9 7608.8 7724.2 6585.2 6836.4 6922.1 6934.9 6946.6 4913.1 4947.9 5008.4 5038.2 5189.7 4755.6 4767.3 4778.2 4981.8 5015.4 16:23:01 INFO - PID 12838 | 16:23:01 INFO - PID 12838 | [#4] prototype.html Cycles:180 Average:4648.91 Median:5261.09 stddev:1356.67 (25.8%) stddev-sans-first:1322.10 16:23:01 INFO - PID 12838 | Values: 380.2 396.8 402.5 403.2 405.8 5413.3 5430.6 5449.5 5471.5 5474.3 5056.1 5246.8 5251.3 5270.8 5331.7 4143.4 4145.9 4154.7 4159.0 4159.9 4143.2 4149.1 4166.0 4172.2 4181.3 3942.6 4091.3 4098.9 4117.5 4118.0 4088.1 4095.8 4104.7 4123.4 4124.4 3575.2 3577.1 3578.3 3580.0 3603.4 4976.9 5204.5 5212.5 5226.9 5228.4 4740.6 4761.3 4761.4 4778.4 4785.4 5613.0 5620.7 5643.5 5659.5 5676.0 3819.4 3996.9 4009.0 4012.9 4022.0 5571.5 5749.4 5791.9 5820.4 5941.8 4048.4 4051.8 4078.2 4084.7 4097.3 4107.1 4110.5 4119.9 4120.7 4145.5 4391.4 4463.6 4564.0 4599.4 4617.6 5583.5 5606.8 5610.9 5638.9 5657.9 1418.2 1420.5 1426.1 1429.1 1430.4 928.1 967.9 969.1 974.0 977.4 4861.3 4862.6 4875.4 4878.5 4887.8 5783.0 5793.9 5802.6 5805.2 5813.5 4659.4 4862.5 4916.4 4945.9 4958.4 3080.6 3093.3 3106.5 3107.7 3115.0 5188.5 5414.6 5438.9 5446.3 5454.2 5950.2 5987.2 5992.6 5994.5 5995.1 5419.8 5437.9 5440.9 5455.9 5466.0 5704.7 5799.3 5828.9 5863.8 5865.2 5745.0 5746.3 5749.1 5764.5 5791.2 5144.3 5158.3 5322.5 5409.0 5414.7 4036.9 4060.7 4065.8 4074.2 4081.5 5810.8 5835.0 5837.6 5844.6 5859.6 5452.0 5607.4 5624.7 5632.4 5655.7 5605.0 5608.0 5616.1 5630.7 5644.6 5396.5 5563.9 5565.8 5568.4 5569.8 5648.9 5658.0 5682.0 5690.7 5707.6 5476.3 5500.7 5504.7 5520.3 5526.3 16:23:01 INFO - PID 12838 | 16:23:01 INFO - PID 12838 | [#5] yui.html Cycles:180 Average:14045.62 Median:27872.29 stddev:17855.74 (64.1%) stddev-sans-first:17877.65 16:23:01 INFO - PID 12838 | Values: 686.9 694.7 700.2 700.9 703.2 11685.2 12103.6 12147.1 12183.0 12191.8 12860.7 13084.9 14405.8 15009.5 15149.8 850.2 868.3 870.0 871.0 871.5 830.8 853.1 864.2 864.7 864.8 899.9 903.8 904.3 905.3 905.6 896.4 897.8 898.3 899.5 900.1 665.9 666.7 667.5 667.6 668.3 14294.9 14390.6 14555.4 14569.2 14704.2 13024.0 13423.6 13829.9 13873.4 13966.7 10622.9 10920.9 10956.5 11252.7 11364.9 2651.7 2662.1 2666.2 2713.5 2774.8 64550.7 64616.4 64788.7 65198.7 65992.7 10213.5 10344.8 10371.8 10475.1 10606.8 21452.9 21453.2 21456.1 21492.1 21499.8 6461.2 6494.2 6528.2 6742.6 6792.5 3195.5 3222.9 3253.1 3261.1 3307.0 3555.4 3555.6 3581.4 3584.2 3590.9 666.7 672.6 677.6 693.6 696.5 541.9 543.1 555.2 565.4 566.7 7754.7 7868.7 8081.5 8465.4 8524.9 532.5 539.3 548.1 554.6 562.6 3640.7 3719.5 3799.6 3823.9 3827.4 63578.7 64986.4 65133.7 65997.3 67452.3 55190.0 55861.7 56218.8 58900.7 59040.0 45775.5 50867.7 51066.0 51427.7 53058.7 7522.4 7569.1 7608.2 7676.5 7761.0 26655.2 27130.5 27605.4 27905.6 27937.0 33271.2 33611.7 33721.5 33743.5 35037.5 9660.3 9969.5 10065.3 10101.3 10124.8 10500.3 10550.2 10593.9 10599.0 10982.2 9823.7 9910.4 10026.1 10040.4 10168.6 9843.5 10191.8 10229.0 10265.3 10665.6 9256.1 9381.0 9479.9 9613.1 9875.0 6936.9 7140.4 7538.9 7723.8 7746.8 8916.6 9056.1 9098.2 9100.9 9182.9 16:23:01 INFO - PID 12838 | -------- Summary: end -------- 16:23:01 INFO - PID 12838 | 16:23:02 INFO - TEST-INFO | 12838: exit 0 16:23:02 INFO - TEST-OK | dromaeo_css | took 1123770ms 16:23:02 INFO - TEST-START | kraken 16:23:02 INFO - operating with platform_type : linux_ 16:23:02 INFO - Initialising browser for kraken test... 16:23:02 INFO - TEST-INFO | started process 13160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUxlVe7/profile http://localhost:53199/getInfo.html) 16:23:06 INFO - PID 13160 | __metrics Screen width/height:1600/1200 16:23:06 INFO - PID 13160 | colorDepth:24 16:23:06 INFO - PID 13160 | Browser inner width/height: 1024/697 16:23:06 INFO - PID 13160 | __metrics 16:23:07 INFO - PID 13160 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:23:07 INFO - PID 13160 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:23:08 INFO - TEST-INFO | 13160: exit 0 16:23:08 INFO - Browser initialized. 16:23:08 INFO - Running cycle 1/1 for kraken test... 16:23:08 INFO - TEST-INFO | started process 13254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUxlVe7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:23:21 INFO - PID 13254 | RSS: Main: 150175744 16:23:21 INFO - PID 13254 | 16:23:23 INFO - PID 13254 | Cycle 1(1): loaded http://localhost:53199/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53199/tests/kraken/driver.html?testName=audio-beat-detection) 16:23:24 INFO - PID 13254 | RSS: Main: 204886016 16:23:24 INFO - PID 13254 | 16:23:27 INFO - PID 13254 | Cycle 1(1): loaded http://localhost:53199/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53199/tests/kraken/driver.html?testName=audio-dft) 16:23:28 INFO - PID 13254 | RSS: Main: 184324096 16:23:28 INFO - PID 13254 | 16:23:31 INFO - PID 13254 | Cycle 1(1): loaded http://localhost:53199/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53199/tests/kraken/driver.html?testName=audio-fft) 16:23:31 INFO - PID 13254 | RSS: Main: 266313728 16:23:31 INFO - PID 13254 | 16:23:33 INFO - PID 13254 | Cycle 1(1): loaded http://localhost:53199/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53199/tests/kraken/driver.html?testName=audio-oscillator) 16:23:34 INFO - PID 13254 | RSS: Main: 177598464 16:23:34 INFO - PID 13254 | 16:23:36 INFO - PID 13254 | Cycle 1(1): loaded http://localhost:53199/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53199/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:23:37 INFO - PID 13254 | RSS: Main: 180535296 16:23:37 INFO - PID 13254 | 16:23:40 INFO - PID 13254 | Cycle 1(1): loaded http://localhost:53199/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53199/tests/kraken/driver.html?testName=imaging-darkroom) 16:23:41 INFO - PID 13254 | RSS: Main: 220397568 16:23:41 INFO - PID 13254 | 16:23:44 INFO - PID 13254 | Cycle 1(1): loaded http://localhost:53199/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53199/tests/kraken/driver.html?testName=imaging-desaturate) 16:23:45 INFO - PID 13254 | RSS: Main: 215281664 16:23:45 INFO - PID 13254 | 16:23:48 INFO - PID 13254 | Cycle 1(1): loaded http://localhost:53199/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53199/tests/kraken/driver.html?testName=json-parse-financial) 16:23:48 INFO - PID 13254 | RSS: Main: 216625152 16:23:48 INFO - PID 13254 | 16:23:50 INFO - PID 13254 | Cycle 1(1): loaded http://localhost:53199/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53199/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:23:51 INFO - PID 13254 | RSS: Main: 180809728 16:23:51 INFO - PID 13254 | 16:23:53 INFO - PID 13254 | Cycle 1(1): loaded http://localhost:53199/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53199/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:23:53 INFO - PID 13254 | RSS: Main: 188354560 16:23:53 INFO - PID 13254 | 16:23:55 INFO - PID 13254 | Cycle 1(1): loaded http://localhost:53199/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53199/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:23:56 INFO - PID 13254 | RSS: Main: 196956160 16:23:56 INFO - PID 13254 | 16:23:59 INFO - PID 13254 | Cycle 1(1): loaded http://localhost:53199/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53199/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:24:00 INFO - PID 13254 | RSS: Main: 206929920 16:24:00 INFO - PID 13254 | 16:24:03 INFO - PID 13254 | Cycle 1(1): loaded http://localhost:53199/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53199/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:24:03 INFO - PID 13254 | RSS: Main: 202919936 16:24:03 INFO - PID 13254 | 16:24:05 INFO - PID 13254 | Cycle 1(1): loaded http://localhost:53199/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53199/tests/kraken/driver.html?testName=ai-astar) 16:24:06 INFO - PID 13254 | RSS: Main: 271687680 16:24:06 INFO - PID 13254 | 16:24:06 INFO - PID 13254 | __start_tp_report 16:24:06 INFO - PID 13254 | _x_x_mozilla_page_load 16:24:06 INFO - PID 13254 | _x_x_mozilla_page_load_details 16:24:06 INFO - PID 13254 | |i|pagename|runs| 16:24:06 INFO - PID 13254 | |0;ai-astar;104;112;111;112;110;110;109;109;110;111 16:24:06 INFO - PID 13254 | |1;audio-beat-detection;149;124;124;159;129;123;128;124;141;124 16:24:06 INFO - PID 13254 | |2;audio-dft;164;162;163;163;162;163;163;163;163;162 16:24:06 INFO - PID 13254 | |3;audio-fft;75;74;75;113;76;76;75;74;95;76 16:24:06 INFO - PID 13254 | |4;audio-oscillator;84;84;116;84;85;84;105;84;85;106 16:24:06 INFO - PID 13254 | |5;imaging-gaussian-blur;113;113;113;113;113;113;113;113;113;113 16:24:06 INFO - PID 13254 | |6;imaging-darkroom;149;150;149;148;149;149;149;149;149;149 16:24:06 INFO - PID 13254 | |7;imaging-desaturate;95;94;94;94;94;94;94;94;94;94 16:24:06 INFO - PID 13254 | |8;json-parse-financial;65;66;65;65;67;66;68;67;67;66 16:24:06 INFO - PID 13254 | |9;json-stringify-tinderbox;55;55;55;59;55;55;55;56;54;55 16:24:06 INFO - PID 13254 | |10;stanford-crypto-aes;82;82;83;82;82;82;89;83;82;82 16:24:06 INFO - PID 13254 | |11;stanford-crypto-ccm;138;136;140;132;140;130;131;131;177;140 16:24:06 INFO - PID 13254 | |12;stanford-crypto-pbkdf2;181;191;190;191;190;190;191;189;190;191 16:24:06 INFO - PID 13254 | |13;stanford-crypto-sha256-iterative;72;72;73;70;69;75;71;71;68;68 16:24:06 INFO - PID 13254 | __end_tp_report 16:24:06 INFO - PID 13254 | __start_cc_report 16:24:06 INFO - PID 13254 | _x_x_mozilla_cycle_collect,2058 16:24:06 INFO - PID 13254 | __end_cc_report 16:24:06 INFO - PID 13254 | __startTimestamp1490484246030__endTimestamp 16:24:06 INFO - PID 13254 | 16:24:06 INFO - PID 13254 | ------- Summary: start ------- 16:24:06 INFO - PID 13254 | Number of tests: 14 16:24:06 INFO - PID 13254 | 16:24:06 INFO - PID 13254 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.50 stddev:2.30 (2.1%) stddev-sans-first:1.13 16:24:06 INFO - PID 13254 | Values: 104.0 112.0 111.0 112.0 110.0 110.0 109.0 109.0 110.0 111.0 16:24:06 INFO - PID 13254 | 16:24:06 INFO - PID 13254 | [#1] audio-beat-detection Cycles:10 Average:132.50 Median:128.50 stddev:12.73 (9.9%) stddev-sans-first:12.02 16:24:06 INFO - PID 13254 | Values: 149.0 124.0 124.0 159.0 129.0 123.0 128.0 124.0 141.0 124.0 16:24:06 INFO - PID 13254 | 16:24:06 INFO - PID 13254 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 16:24:06 INFO - PID 13254 | Values: 164.0 162.0 163.0 163.0 162.0 163.0 163.0 163.0 163.0 162.0 16:24:06 INFO - PID 13254 | 16:24:06 INFO - PID 13254 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.50 stddev:12.91 (17.1%) stddev-sans-first:13.52 16:24:06 INFO - PID 13254 | Values: 75.0 74.0 75.0 113.0 76.0 76.0 75.0 74.0 95.0 76.0 16:24:06 INFO - PID 13254 | 16:24:06 INFO - PID 13254 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:84.00 stddev:12.28 (14.6%) stddev-sans-first:12.71 16:24:06 INFO - PID 13254 | Values: 84.0 84.0 116.0 84.0 85.0 84.0 105.0 84.0 85.0 106.0 16:24:06 INFO - PID 13254 | 16:24:06 INFO - PID 13254 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:113.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:24:06 INFO - PID 13254 | Values: 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 16:24:06 INFO - PID 13254 | 16:24:06 INFO - PID 13254 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 16:24:06 INFO - PID 13254 | Values: 149.0 150.0 149.0 148.0 149.0 149.0 149.0 149.0 149.0 149.0 16:24:06 INFO - PID 13254 | 16:24:06 INFO - PID 13254 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 16:24:06 INFO - PID 13254 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 16:24:06 INFO - PID 13254 | 16:24:06 INFO - PID 13254 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:66.50 stddev:1.03 (1.6%) stddev-sans-first:1.00 16:24:06 INFO - PID 13254 | Values: 65.0 66.0 65.0 65.0 67.0 66.0 68.0 67.0 67.0 66.0 16:24:06 INFO - PID 13254 | 16:24:06 INFO - PID 13254 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.00 stddev:1.35 (2.5%) stddev-sans-first:1.42 16:24:06 INFO - PID 13254 | Values: 55.0 55.0 55.0 59.0 55.0 55.0 55.0 56.0 54.0 55.0 16:24:06 INFO - PID 13254 | 16:24:06 INFO - PID 13254 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.00 stddev:2.18 (2.7%) stddev-sans-first:2.29 16:24:06 INFO - PID 13254 | Values: 82.0 82.0 83.0 82.0 82.0 82.0 89.0 83.0 82.0 82.0 16:24:06 INFO - PID 13254 | 16:24:06 INFO - PID 13254 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:139.00 stddev:13.79 (9.9%) stddev-sans-first:14.62 16:24:06 INFO - PID 13254 | Values: 138.0 136.0 140.0 132.0 140.0 130.0 131.0 131.0 177.0 140.0 16:24:06 INFO - PID 13254 | 16:24:06 INFO - PID 13254 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.40 Median:190.50 stddev:3.03 (1.6%) stddev-sans-first:0.71 16:24:06 INFO - PID 13254 | Values: 181.0 191.0 190.0 191.0 190.0 190.0 191.0 189.0 190.0 191.0 16:24:06 INFO - PID 13254 | 16:24:06 INFO - PID 13254 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.50 stddev:2.23 (3.1%) stddev-sans-first:2.33 16:24:06 INFO - PID 13254 | Values: 72.0 72.0 73.0 70.0 69.0 75.0 71.0 71.0 68.0 68.0 16:24:06 INFO - PID 13254 | -------- Summary: end -------- 16:24:06 INFO - PID 13254 | 16:24:07 INFO - TEST-INFO | 13254: exit 0 16:24:07 INFO - TEST-OK | kraken | took 64488ms 16:24:07 INFO - SUITE-END | took 1188s 16:24:07 INFO - Completed test suite (00:19:48) 16:24:07 INFO - javascript benchmark 16:24:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6469.430319840456, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2664.973350266497, 2693.1247344613007, 2727.1000569811963, 2733.2893447703605, 2734.863256837158, 5101.285819985205, 5223.791048358061, 5228.6078544109205, 5268.8155914542995, 5311.73441327934, 5176.50823171799, 5185.766640501177, 5209.453007434222, 5210.713410762407, 5211.478852114787, 4730.385049943503, 4758.904821903559, 4782.521747825224, 4782.83260085897, 4827.227643577028, 4787.976060119695, 4805.663603547753, 4808.807647694106, 4824.517548245182, 4829.227323628203, 4807.78364973577, 4815.759212039402, 4820.855374338776, 4827.275908613701, 4873.585745211643, 4826.662133650646, 4831.637627177958, 4831.855044348676, 4873.122837889178, 4879.365682461293, 4752.9762351188365, 4762.047590481883, 4764.6426518011285, 4786.593139583139, 4822.95177048232, 5250.579953603703, 5267.0, 5276.709780962045, 5315.176147697113, 5315.73421328932, 5582.692951887645, 5624.043912534838, 5634.295713035871, 5636.71816409182, 5689.203511508392, 4573.49691533931, 5563.109902415635, 5625.268715067015, 5730.025895597759, 5730.856728581819, 5257.342832145981, 5260.684358938438, 5265.420803711589, 5268.025415298182, 5312.73436328182, 5813.476787089182, 5817.0401883689565, 5824.767009319579, 5827.79602713903, 5828.0966450200285, 5412.242286079952, 5464.672119672832, 5473.507384335349, 5480.3971563128025, 5587.720613969285, 5622.24099746529, 5638.35158956717, 5644.294463192101, 5699.401562835843, 5707.828765137053, 5575.0522411190195, 5583.106702927512, 5594.916076258859, 5595.076812326002, 5595.63628364155, 5461.699606521679, 5532.695701736363, 5588.497035266845, 5589.049861523551, 5594.13290939905, 4609.446866376056, 4665.2768820832825, 4675.509071547506, 4695.882602934886, 4696.600788932979, 4009.0578714002186, 4012.2376748417705, 4012.9799351003057, 4016.738911970771, 4030.435738996543, 4762.59517940972, 4765.0, 4778.068276686083, 4780.211265141213, 4811.0, 5513.641613295123, 5517.475839795213, 5572.359178694421, 5579.8884022320135, 5660.462256085665, 4718.646101542398, 4733.739644319596, 4767.165745994437, 4773.71357718538, 4782.976085119552, 4938.506149385104, 4943.332650092263, 4966.230234313687, 4969.453360130383, 5014.2979982802435, 5122.052420302256, 5239.764210610531, 5241.764120614505, 5241.921371179512, 5245.263236725799, 5557.944420555905, 5590.468905453975, 5615.241942337732, 5625.746841392229, 5669.971650141723, 5190.221466779863, 5247.1866860636665, 5258.316418865523, 5266.578673706018, 5286.392064912584, 5528.06022976087, 5552.167174923794, 5556.083246264321, 5558.471945165203, 5618.157276408571, 5500.257465242301, 5510.090835012178, 5565.7217139143695, 5635.577331700221, 5637.661740295595, 5406.675599463887, 5416.647917885325, 5420.4850539198715, 5420.83737487876, 5422.810201642924, 5391.865203369947, 5485.61600687948, 5514.420985796433, 5524.1989911463415, 5535.114381698909, 5385.0, 5394.676319420847, 5410.864728381822, 5427.3215848019, 5430.429804870431, 5500.1749737539685, 5510.712506228201, 5514.228008078952, 5526.86182845416, 5560.277163968658, 5187.0, 5237.895242095061, 5242.633015688865, 5245.082110630548, 5253.290805741329], "value": 5108.915556318276, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.9612423254605, 709.7161135545782, 731.7182884589434, 1056.7146870345011, 1077.1490522487236, 24417.0, 29668.851655741717, 30280.091597252063, 30324.84837575809, 30488.695113048892, 32056.519152212677, 32341.191470213256, 32390.0, 32460.0, 32467.675323246818, 5526.171074338861, 5681.233033540481, 7133.999999999987, 7251.16611589666, 7301.598412087333, 7136.072310599615, 7293.307135822089, 7297.343239108479, 7319.304666056716, 7321.926780732178, 7341.743038993636, 7438.479306448551, 7440.367568756662, 7570.31867131958, 7579.052618422697, 7474.028376311072, 7524.623768811538, 7536.924630753704, 7537.773866784005, 7540.132884718273, 7396.815079622998, 7435.7397491088095, 7448.106227252711, 7452.813679657997, 7460.14208366034, 32438.189045273823, 32549.6745032549, 32625.02124936256, 32640.183995400068, 32642.0, 2499.713678214154, 2514.0, 2515.8364706294033, 2529.481456301454, 2580.1485509781915, 23228.187013454615, 23344.299671009896, 23762.762372376226, 23980.880095599583, 24064.0, 2576.2142546523305, 2611.9347016324555, 2616.2543675052707, 2632.4866651003063, 2647.470505898828, 152233.0, 152540.0, 152903.0, 153361.23319383332, 153502.0, 41718.37422438666, 41748.79125604353, 41775.1644967099, 41781.37327940023, 41806.581934180875, 44051.0, 44079.77960110179, 44128.3380749289, 44183.77908110503, 44209.557904421185, 12925.612231633066, 13189.142705724098, 13192.538261160813, 13222.603321900358, 13251.072424930355, 9089.545522723838, 9236.214921731593, 9655.855162172573, 10709.78580428387, 10772.89227107719, 11708.590199342982, 11732.178747487595, 11743.354115523729, 11757.764844703059, 11917.821232681517, 4890.481402077933, 4945.67853089548, 4992.301077849104, 5008.424031236382, 5081.161608334657, 855.1363123245567, 883.5673408806832, 891.6522556203086, 898.9146031127033, 924.8381533231658, 19854.70217946732, 20629.0, 20711.68932465984, 20743.58512829735, 21167.364979050653, 918.911090357928, 947.3984020147257, 965.4255717847869, 974.8732664753537, 975.0, 10665.146788256921, 11138.83042280549, 11233.775324493465, 11286.07364271985, 11288.0, 213488.0, 214085.0, 214100.0, 214622.0, 215132.0, 41076.1784764303, 41180.79409602933, 41261.174776504304, 41262.38106428406, 41283.380749288786, 1196.419736427849, 1234.2902830872285, 1243.570968016033, 1246.2709315050615, 1250.9061820363509, 18670.90664546723, 18763.437096887115, 19608.8039119607, 19796.50508737293, 19877.701834472206, 29782.851085744434, 29905.70094299029, 30039.249018774706, 30043.3991320168, 30057.54913676253, 219859.0, 220265.0, 220836.0, 221273.0, 221723.0, 21347.25284615031, 21558.353249402542, 21567.2451464198, 28390.290242744097, 28577.0, 23668.52662946697, 25040.248792535524, 29457.558136628395, 30261.697383026767, 30268.394632107676, 22210.77789222087, 22630.094796208625, 23496.647550286416, 24075.51848963046, 25016.37459063538, 23696.644550331413, 24266.0, 24372.756272437047, 24620.753792461845, 24835.62746558767, 27225.0, 27449.725502745518, 27872.581911270943, 27938.58092128579, 27956.86021569879, 23551.764482355644, 24135.879320603988, 24149.0, 24200.0, 24638.630420543348, 19315.90342048281, 20318.59362812706, 20510.589788204452, 20584.176632935112, 20614.0], "value": 14121.933777681255, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.1325104030493, 419.8278705730651, 430.3566168577975, 435.7929983257953, 440.64748201438863, 12148.635540933765, 16482.340706371746, 17151.656966860653, 17211.65576688467, 17307.82692173078, 13449.32753362333, 13495.0, 17015.82984170158, 17471.82528174718, 17694.734578981326, 5486.149646804752, 5519.337679478458, 5678.659280443187, 5715.799947001856, 5716.7141642917895, 5638.859028524299, 5687.061634830268, 5689.544836413077, 5693.430656934315, 5694.5159661428825, 5397.163439666858, 5573.359063707685, 5599.860003499904, 5600.1599760035915, 5609.298837645294, 5512.862178445571, 5542.168674698787, 5577.9163312550345, 5622.072358060915, 5623.943760562423, 5111.872203194913, 5150.459201783834, 5156.381234251914, 5156.819511317086, 5163.406208286057, 22009.0, 22277.331680049625, 22281.66577501339, 22322.88838555797, 22368.77631223683, 1536.60816491795, 1540.2606748760545, 1542.8611424971693, 1584.952451426459, 1591.6737068900964, 13316.201027938354, 13926.0, 13972.93013534936, 14082.859171408258, 14486.927565362106, 1688.4512533426685, 1694.847463728258, 1706.5733566608349, 1721.1652348610914, 1755.782935860174, 86588.0, 89084.55457722735, 90676.09323906743, 90985.09014909832, 91623.54188229083, 10515.263931524873, 10681.626143084955, 10762.24664273509, 10865.130789536817, 11005.0, 15399.23003849803, 15468.381264749509, 15523.301451434487, 15545.455909043128, 15547.300371483085, 6786.558873673195, 7102.4318054555515, 7549.660265288076, 7844.657106798289, 8003.439759216799, 7019.192792828788, 7284.599347035964, 7286.635668216568, 7326.853462930711, 7338.853222935511, 6841.247462779091, 6885.655717214119, 6956.912926122143, 6964.268751781091, 6967.965160174268, 2041.5610643711673, 2051.056514003545, 2057.79422057796, 2071.5856828634332, 2143.389134096775, 833.4832403909494, 846.8856704344958, 847.5338563789891, 866.8873046503915, 877.7015814623059, 15944.362225511082, 16441.424550140688, 16853.578660533338, 17101.828981710274, 17143.74284385735, 863.4646519158163, 870.4820631724114, 871.3639043498155, 878.8462019146624, 894.4856707393145, 8503.659853605786, 9175.678851240174, 9233.676821311223, 9322.720318390458, 9430.10414010668, 387375.0, 391746.0, 399342.0, 425060.0, 425430.0, 65603.34396656067, 87830.0, 88392.0, 88943.55528222317, 91960.0803991965, 1090.5310716392028, 1130.7851508213414, 1134.1720544002924, 1145.977080458403, 1146.358039497884, 17062.402815901383, 17254.741178882578, 17730.290788368322, 17742.0, 17849.553761156076, 37805.0, 37904.810475947445, 38692.6130738689, 44106.11787764291, 46118.0, 45682.0, 45738.0, 48583.75708121437, 54593.727031364586, 54998.72500637471, 5219.422493911743, 6828.317168283132, 7630.465867389229, 7643.235676432535, 7886.802829929297, 11168.832467512831, 11236.157288203582, 11333.886661133283, 11464.426778660867, 11763.0, 9528.52357382142, 9863.704088877344, 9884.654037108667, 9953.751156221153, 10077.19382449417, 8624.698135565224, 9027.322950778587, 9071.319651026331, 9107.408018478778, 9126.083522460358, 9091.136342047495, 9462.432254064779, 9685.0, 9716.514174291116, 10198.439085850052, 7562.848743024999, 7659.731909383145, 7804.102528209101, 7815.0, 7824.491408058458, 9582.808343832945, 9621.134097931219, 9744.171745401436, 9782.217422606032, 10279.331843430153], "value": 8601.76446844089, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1213.939303034848, 1269.3653173413293, 1281.2120545864295, 1289.3553223388305, 1290.7805673035582, 9432.339736218468, 9804.55879485423, 9823.066808653175, 9825.950870245639, 9826.066523680256, 9447.905520944789, 9931.0, 9938.0, 9938.105570498654, 9945.05521975413, 2190.310052333518, 2232.408411770882, 2235.0724449353497, 2235.2623634200677, 2238.250186187629, 1833.0926191535143, 2139.2940329691164, 2226.3988723044768, 2234.6759719840616, 2237.7090978172896, 1899.2782742557808, 2143.7749036351192, 2204.1403852497538, 2221.4779526811185, 2229.3534874886263, 2150.9462263443384, 2160.8811515366647, 2167.8048975592114, 2170.7612162662094, 2179.5422961178174, 2139.208492857637, 2146.034284571949, 2147.8281737460966, 2148.419926619804, 2149.9355019349446, 9793.804123917482, 10040.246981476346, 10054.597816087347, 10058.547365368502, 10062.0, 5356.437574054746, 5569.0, 5571.415001424833, 5572.693501857396, 5573.303337082864, 3042.1481985044, 3152.1489197916435, 3159.936801263962, 3190.409774191782, 3206.070239630504, 929.9302552308604, 969.5249327829383, 1012.5190534496129, 1027.542743479152, 1048.3343077145992, 14344.856551434457, 14489.855101449062, 14498.927505362512, 14500.347484363228, 14519.128852268897, 4685.882852928636, 4765.237561990134, 4778.689385190021, 4793.01743142655, 4805.471398146201, 10929.945350273198, 11074.944625276821, 11074.944625276821, 11075.556977720962, 11079.061164296378, 5223.451537588575, 5229.241759944786, 5229.686218826882, 5236.92144617831, 5239.973800130975, 4861.173600487926, 4916.336294600254, 4955.8513244602, 5020.899582008413, 5022.397312322545, 3632.2917031178667, 3743.21392507571, 3788.6211378862445, 3818.9427158592644, 3867.8340129527555, 1030.1192480429274, 1039.1219419590434, 1040.438163391775, 1051.4795176387738, 1056.3081181825917, 578.1068249554448, 597.2504506843883, 638.9073584330339, 660.0495286787011, 662.9701663425158, 5279.41926388097, 5343.251944727741, 5367.704776237344, 5409.323834520685, 5634.267545219095, 783.5729527407576, 800.2197857089408, 805.5005896344304, 814.9633266503022, 820.5856042698518, 3277.524758909945, 3287.6547962464074, 3302.1249368917256, 3476.200473891019, 3616.3129005488872, 12045.879541204651, 12978.0, 12981.805272920914, 12997.935010324887, 13013.0, 12720.109592328448, 12866.806997895039, 12938.870611293954, 12976.805347919788, 12981.221126732426, 9319.627214911328, 9353.766155846159, 9392.765180870396, 9393.906060939304, 9427.764305892544, 5309.707966061904, 5315.2064249967725, 5403.567714582902, 5475.425080366664, 5607.719614019201, 11312.434378281218, 11500.654980350602, 11525.88474115248, 11662.300261984308, 11702.824457632973, 11680.182387233152, 11747.0, 11771.646850594496, 11835.349055802013, 11870.228435151688, 8186.754397368089, 8194.713185038496, 8290.046644635944, 8372.916270837213, 8398.244158025807, 9026.638934442812, 9037.548122593975, 9104.453732776055, 9106.134917182857, 9119.908800911906, 7281.526700764433, 7350.228226036403, 7350.926490735024, 7355.632218389166, 7529.058867641545, 7469.365103966006, 7481.513701609378, 7580.886286705814, 7608.771736847903, 7724.227577242231, 6585.242697089896, 6836.418904393182, 6922.06552115458, 6934.93065069363, 6946.583205007716, 4913.115639184981, 4947.876303092451, 5008.373953255843, 5038.2190760432195, 5189.6886186828915, 4755.636576776155, 4767.284907263938, 4778.1638213311835, 4981.825636102719, 5015.448300686849], "value": 4571.485573539765, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.1807105687245, 396.8253968253968, 402.4647219198466, 403.18556515838026, 405.81941036238885, 5413.296271484702, 5430.565554755615, 5449.509544141027, 5471.470901268679, 5474.275603185004, 5056.089903817311, 5246.842594722155, 5251.343582052244, 5270.841874743764, 5331.680099194051, 4143.357779544161, 4145.917081658365, 4154.709170358076, 4158.97920510397, 4159.875203743877, 4143.212789569987, 4149.128682976579, 4165.958340416587, 4172.228137794503, 4181.310083836163, 3942.645161935425, 4091.284025295576, 4098.913787846223, 4117.526484454281, 4118.011677197466, 4088.08018195905, 4095.8361665533344, 4104.651104656108, 4123.443335149746, 4124.42258083867, 3575.1777091269155, 3577.0878426001464, 3578.3380074686265, 3579.9642003579893, 3603.40543810271, 4976.925346119811, 5204.505571970657, 5212.50481204285, 5226.895462090737, 5228.398734145584, 4740.644451666139, 4761.333413322138, 4761.40482439695, 4778.351468743278, 4785.425748910118, 5613.0, 5620.690862002588, 5643.492085712264, 5659.490645841894, 5676.035074037423, 3819.446180303868, 3996.900077498057, 4008.9799551002056, 4012.87317721608, 4022.0, 5571.526420254283, 5749.3963133871175, 5791.884162316772, 5820.3888591698105, 5941.781335251976, 4048.4332193492933, 4051.8379264829077, 4078.1639763848934, 4084.6528045116497, 4097.303458412077, 4107.116969851496, 4110.486189226347, 4119.855805046809, 4120.670346372283, 4145.481814773153, 4391.363252328459, 4463.598276155161, 4563.977180114144, 4599.448066232074, 4617.58441740245, 5583.525400341016, 5606.803761868315, 5610.915836262459, 5638.915416268759, 5657.943420565742, 1418.2412409360943, 1420.5383250443647, 1426.0588011912296, 1429.0639631041684, 1430.3849344781636, 928.062656716721, 967.8596603492595, 969.1471505075489, 973.9707808765748, 977.3647129365969, 4861.343718598015, 4862.586680132157, 4875.43932447773, 4878.487758785347, 4887.7556122194455, 5782.971085144547, 5793.94206057934, 5802.603578671791, 5805.216295800097, 5813.5349172066135, 4659.394278743742, 4862.465128835825, 4916.434610019894, 4945.876353091129, 4958.380202474691, 3080.630324361091, 3093.334932989418, 3106.4718997770433, 3107.673694262115, 3115.0, 5188.533032027136, 5414.620976531605, 5438.864028399322, 5446.2647542582035, 5454.236406903036, 5950.19672344228, 5987.221661184019, 5992.58051936369, 5994.460498555151, 5995.070764031495, 5419.783208671688, 5437.945620543744, 5440.945590544123, 5455.918161227585, 5465.9726701366235, 5704.743286552032, 5799.333076696234, 5828.883422331445, 5863.765449381977, 5865.208196893364, 5744.971275143597, 5746.281714785652, 5749.108888122348, 5764.538836892954, 5791.189233507396, 5144.331236939323, 5158.303629010035, 5322.520973112439, 5408.972295263888, 5414.7021913795115, 4036.9394459083724, 4060.675145988373, 4065.7560546367313, 4074.1851629673592, 4081.4898137732785, 5810.84998550539, 5834.970825145847, 5837.620554664103, 5844.6493210405815, 5859.648421094748, 5451.974154344377, 5607.383187849415, 5624.7187640616985, 5632.436756324335, 5655.7172141393585, 5604.982206405609, 5608.0, 5616.129499927518, 5630.7466164023535, 5644.576656750843, 5396.460353964572, 5563.916541251965, 5565.77736890536, 5568.387477377566, 5569.832905012856, 5648.926703926241, 5658.009848276452, 5682.005649011489, 5690.71546422669, 5707.600467967202, 5476.288082549243, 5500.734830988815, 5504.697241651747, 5520.337559492887, 5526.286851076179], "value": 4237.410512897194, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.9089099054256, 694.6630884021246, 700.2297472779941, 700.8528209076094, 703.2334755116923, 11685.182037257395, 12103.636890893287, 12147.088968327389, 12183.025357971352, 12191.817122743154, 12860.742785144315, 13084.869151308483, 14405.78391324131, 15009.474668386609, 15149.848501514982, 850.2305413600686, 868.3053557154283, 869.9608517616691, 871.020102384817, 871.4509858788986, 830.7839961609994, 853.1298075962515, 864.1660797330575, 864.6930339729399, 864.7924498120437, 899.9370044096916, 903.8373092843285, 904.3036861616552, 905.302916754099, 905.5879574793486, 896.3904544909459, 897.8294124116462, 898.3262553085186, 899.4827973914993, 900.1043961258524, 665.8668266346701, 666.6500087454077, 667.546068673302, 667.629465646566, 668.3283300283233, 14294.92852535741, 14390.568282951528, 14555.417783288656, 14569.198694071822, 14704.191269480174, 13024.0, 13423.597292081253, 13829.930850345683, 13873.4450621975, 13966.720665586632, 10622.893771062345, 10920.93161989517, 10956.506957186866, 11252.66242012741, 11364.863513648652, 2651.6950550686724, 2662.1305971444676, 2666.186813022047, 2713.5386984212732, 2774.7780177585746, 64550.67724661394, 64616.3538364615, 64788.67605661989, 65198.674006630135, 65992.67003664999, 10213.489325533694, 10344.793104137874, 10371.844422333672, 10475.109615682752, 10606.787864242671, 21452.89273553622, 21453.249136280156, 21456.141754329965, 21492.14031438756, 21499.78500214978, 6461.19235095613, 6494.220693516808, 6528.183977002875, 6742.561733487406, 6792.490563207779, 3195.504696772004, 3222.9194270142966, 3253.072874230833, 3261.0542942546394, 3307.015790525665, 3555.4311310190765, 3555.6266592007983, 3581.3732596795458, 3584.175639602906, 3590.8743193988084, 666.6799936030733, 672.5527524196452, 677.5697432130534, 693.5873155472486, 696.4602433114276, 541.8834950485585, 543.1174341694746, 555.1672491263105, 565.4289167940327, 566.6741623566465, 7754.651040703182, 7868.685252589832, 8081.515109093473, 8465.365097617703, 8524.8721269181, 532.5226272440967, 539.3312292757031, 548.0737553534514, 554.5729788063169, 562.5780664501624, 3640.672339489459, 3719.5350581177354, 3799.639034291738, 3823.9426408603895, 3827.3684842000757, 63578.68210658917, 64986.35013649803, 65133.67433162804, 65997.34002660008, 67452.32547674558, 55190.0, 55861.72069139628, 56218.820918352634, 58900.7054964731, 59040.0, 45775.542244577126, 50867.745661272194, 51065.97868042618, 51427.742861286206, 53058.73470632622, 7522.360599348897, 7569.1295501018085, 7608.16310205888, 7676.462647614613, 7760.961195193988, 26655.200343989713, 27130.457390851676, 27605.44789104247, 27905.58141627918, 27937.0, 33271.16822079467, 33611.663883361834, 33721.49417758785, 33743.4938475928, 35037.47443788294, 9660.275479338938, 9969.451680157661, 10065.345752526062, 10101.292909496266, 10124.797504049731, 10500.264981451224, 10550.208734344802, 10593.89406105929, 10598.970635769103, 10982.231243812856, 9823.656172033945, 9910.35582687123, 10026.097651211427, 10040.447775372424, 10168.644097456554, 9843.458609776531, 10191.847122293024, 10229.0, 10265.332753371007, 10665.626703065356, 9256.120668536478, 9381.0, 9479.905200948178, 9613.086756758097, 9875.0, 6936.930630693629, 7140.428765698835, 7538.924610753822, 7723.845523089394, 7746.767596972099, 8916.55417229123, 9056.13966673165, 9098.181163695299, 9100.908990910006, 9182.908170918472], "value": 6098.116754522814, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 111.0, 112.0, 110.0, 110.0, 109.0, 109.0, 110.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 124.0, 159.0, 129.0, 123.0, 128.0, 124.0, 141.0, 124.0], "value": 132.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 163.0, 162.0, 163.0, 163.0, 163.0, 163.0, 162.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 113.0, 76.0, 76.0, 75.0, 74.0, 95.0, 76.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 116.0, 84.0, 85.0, 84.0, 105.0, 84.0, 85.0, 106.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 148.0, 149.0, 149.0, 149.0, 149.0, 149.0, 149.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 67.0, 66.0, 68.0, 67.0, 67.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 59.0, 55.0, 55.0, 55.0, 56.0, 54.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 82.0, 82.0, 82.0, 89.0, 83.0, 82.0, 82.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 140.0, 132.0, 140.0, 130.0, 131.0, 131.0, 177.0, 140.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 191.0, 190.0, 191.0, 190.0, 190.0, 191.0, 189.0, 190.0, 191.0], "value": 189.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 70.0, 69.0, 75.0, 71.0, 71.0, 68.0, 68.0], "value": 70.9, "unit": "score"}]}]} 16:24:07 INFO - Return code: 0 16:24:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:24:07 ERROR - # TBPL SUCCESS # 16:24:07 INFO - Running post-action listener: _resource_record_post_action 16:24:07 INFO - [mozharness: 2017-03-25 23:24:07.854952Z] Finished run-tests step (success) 16:24:07 INFO - Running post-run listener: _resource_record_post_run 16:24:07 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 366219264; Read time: 8; Write time: 237112 16:24:07 INFO - TinderboxPrint: CPU usage
12.9% 16:24:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:24:07 INFO - TinderboxPrint: I/O write bytes / time
366,219,264 / 237,112 16:24:07 INFO - TinderboxPrint: CPU idle
8,373.2 (87.0%) 16:24:07 INFO - TinderboxPrint: CPU user
1,200.2 (12.5%) 16:24:07 INFO - TinderboxPrint: Swap in / out
0 / 0 16:24:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106164224; Read time: 0; Write time: 93076 16:24:07 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 260055040; Read time: 8; Write time: 144036 16:24:08 INFO - Running post-run listener: _upload_blobber_files 16:24:08 INFO - Blob upload gear active. 16:24:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:24:08 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 16:24:08 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'] 16:24:08 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 16:24:08 INFO - (blobuploader) - INFO - Open directory for files ... 16:24:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:24:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:24:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:24:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:24:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:24:09 INFO - (blobuploader) - INFO - Done attempting. 16:24:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:24:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:24:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:24:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:24:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:24:13 INFO - (blobuploader) - INFO - Done attempting. 16:24:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:24:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:24:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:24:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:24:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:24:13 INFO - (blobuploader) - INFO - Done attempting. 16:24:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:24:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:24:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:24:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:24:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:24:14 INFO - (blobuploader) - INFO - Done attempting. 16:24:14 INFO - (blobuploader) - INFO - Iteration through files over. 16:24:14 INFO - Return code: 0 16:24:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:24:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:24:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/778a7374007b064f7824cce81be8541b01e92c03f8c8d16e9db39c4100507f9e5c741be9f582d49ea19bee951aadfecad010741696078e035c26dfc59d82d451", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29c0af99e51033c45b266bcff7e83b0803d3807ef6ad8b2eb38f3509a1af2f21fec0ccf1266fa505b135ee2717bbe2a0a9221ea20ec63d3deb6cfa511b2780ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/505e284a450d2eeb2f9896b02c6db9dd1f0e5f78ff3864da073a9a8a24fb819882c9a85c754cf0f232625d71fbf760cc178057616300ab39a279cf7ee2177606", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/50ae180a9077dc19e7b86f7d3cd6151e94bc518edbb0b5767c0dfcae0a60ed6e692249b8c7b599b3c4cefcf38099d78b458a8bc74bd51352004a4e995a26d04e"} 16:24:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:24:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:24:14 INFO - Contents: 16:24:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/778a7374007b064f7824cce81be8541b01e92c03f8c8d16e9db39c4100507f9e5c741be9f582d49ea19bee951aadfecad010741696078e035c26dfc59d82d451", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29c0af99e51033c45b266bcff7e83b0803d3807ef6ad8b2eb38f3509a1af2f21fec0ccf1266fa505b135ee2717bbe2a0a9221ea20ec63d3deb6cfa511b2780ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/505e284a450d2eeb2f9896b02c6db9dd1f0e5f78ff3864da073a9a8a24fb819882c9a85c754cf0f232625d71fbf760cc178057616300ab39a279cf7ee2177606", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/50ae180a9077dc19e7b86f7d3cd6151e94bc518edbb0b5767c0dfcae0a60ed6e692249b8c7b599b3c4cefcf38099d78b458a8bc74bd51352004a4e995a26d04e"} 16:24:14 INFO - Running post-run listener: copy_logs_to_upload_dir 16:24:14 INFO - Copying logs to upload dir... 16:24:14 INFO - mkdir: /builds/slave/test/build/upload/logs 16:24:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.656087 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-03-25 16:24:13.723389) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-25 16:24:13.727691) ========= 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=4300f881736b422476174874000001bc-1490480327.798592-1876497116 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/778a7374007b064f7824cce81be8541b01e92c03f8c8d16e9db39c4100507f9e5c741be9f582d49ea19bee951aadfecad010741696078e035c26dfc59d82d451", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29c0af99e51033c45b266bcff7e83b0803d3807ef6ad8b2eb38f3509a1af2f21fec0ccf1266fa505b135ee2717bbe2a0a9221ea20ec63d3deb6cfa511b2780ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/505e284a450d2eeb2f9896b02c6db9dd1f0e5f78ff3864da073a9a8a24fb819882c9a85c754cf0f232625d71fbf760cc178057616300ab39a279cf7ee2177606", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/50ae180a9077dc19e7b86f7d3cd6151e94bc518edbb0b5767c0dfcae0a60ed6e692249b8c7b599b3c4cefcf38099d78b458a8bc74bd51352004a4e995a26d04e"} build_url:https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011186 build_url: 'https://queue.taskcluster.net/v1/task/A-ewyOJcScak6p9O5Ujp2g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/778a7374007b064f7824cce81be8541b01e92c03f8c8d16e9db39c4100507f9e5c741be9f582d49ea19bee951aadfecad010741696078e035c26dfc59d82d451", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29c0af99e51033c45b266bcff7e83b0803d3807ef6ad8b2eb38f3509a1af2f21fec0ccf1266fa505b135ee2717bbe2a0a9221ea20ec63d3deb6cfa511b2780ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/505e284a450d2eeb2f9896b02c6db9dd1f0e5f78ff3864da073a9a8a24fb819882c9a85c754cf0f232625d71fbf760cc178057616300ab39a279cf7ee2177606", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/50ae180a9077dc19e7b86f7d3cd6151e94bc518edbb0b5767c0dfcae0a60ed6e692249b8c7b599b3c4cefcf38099d78b458a8bc74bd51352004a4e995a26d04e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-25 16:24:13.753191) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 16:24:13.753536) ========= 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=4300f881736b422476174874000001bc-1490480327.798592-1876497116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 16:24:13.839530) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-25 16:24:13.839851) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-25 16:24:13.840208) ========= ========= Total master_lag: 0.17 =========