builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1494442981.21 results: success (0) revision: 8a43b69fbae255a2af98f11507862437d6303033 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 12:03:01.209923) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 12:03:01.210367) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 12:03:01.210649) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 12:03:01.225475) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:03:01.225812) ========= 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=0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-10 12:03:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2017-05-10 12:03:01 (219 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.218563 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:03:01.458757) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:03:01.459122) ========= 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=0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017462 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:03:01.508704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:03:01.512086) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8a43b69fbae255a2af98f11507862437d6303033 --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 8a43b69fbae255a2af98f11507862437d6303033 --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=0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-10 12:03:01,674 truncating revision to first 12 chars 2017-05-10 12:03:01,675 Setting DEBUG logging. 2017-05-10 12:03:01,675 attempt 1/10 2017-05-10 12:03:01,675 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8a43b69fbae2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-10 12:03:02,118 unpacking tar archive at: mozilla-central-8a43b69fbae2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.774283 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:03:02.299648) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 12:03:02.301702) ========= script_repo_revision: 8a43b69fbae255a2af98f11507862437d6303033 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 12:03:02.302076) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 12:03:02.302337) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 12:03:02.313211) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-10 12:03:02.313509) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:03:02 INFO - MultiFileLogger online at 20170510 12:03:02 in /builds/slave/test 12:03:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 12:03:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:03:02 INFO - {'append_to_log': False, 12:03:02 INFO - 'base_work_dir': '/builds/slave/test', 12:03:02 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 12:03:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:03:02 INFO - 'branch': 'Firefox-Non-PGO', 12:03:02 INFO - 'buildbot_json_path': 'buildprops.json', 12:03:02 INFO - 'config_files': ('talos/linux_config.py',), 12:03:02 INFO - 'default_actions': ('clobber', 12:03:02 INFO - 'read-buildbot-config', 12:03:02 INFO - 'download-and-extract', 12:03:02 INFO - 'populate-webroot', 12:03:02 INFO - 'create-virtualenv', 12:03:02 INFO - 'install', 12:03:02 INFO - 'run-tests'), 12:03:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:03:02 INFO - 'download_minidump_stackwalk': True, 12:03:02 INFO - 'download_symbols': 'ondemand', 12:03:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:03:02 INFO - 'tooltool.py': '/tools/tooltool.py', 12:03:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:03:02 INFO - '/tools/misc-python/virtualenv.py')}, 12:03:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:03:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:03:02 INFO - 'gecko_profile': False, 12:03:02 INFO - 'gecko_profile_interval': 0, 12:03:02 INFO - 'installer_path': 'installer.exe', 12:03:02 INFO - 'log_level': 'info', 12:03:02 INFO - 'log_name': 'talos', 12:03:02 INFO - 'log_to_console': True, 12:03:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:03:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:03:02 INFO - 'opt_config_files': (), 12:03:02 INFO - 'pip_index': False, 12:03:02 INFO - 'suite': 'dromaeojs-e10s', 12:03:02 INFO - 'system_bits': '32', 12:03:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:03:02 INFO - 'title': 'talos-linux64-ix-058', 12:03:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:03:02 INFO - 'use_talos_json': True, 12:03:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:03:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:03:02 INFO - 'work_dir': 'build'} 12:03:02 INFO - [mozharness: 2017-05-10 19:03:02.582884Z] Running clobber step. 12:03:02 INFO - Running pre-action listener: _resource_record_pre_action 12:03:02 INFO - Running main action method: clobber 12:03:02 INFO - rmtree: /builds/slave/test/build 12:03:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:03:04 INFO - Running post-action listener: _resource_record_post_action 12:03:04 INFO - [mozharness: 2017-05-10 19:03:04.063660Z] Finished clobber step (success) 12:03:04 INFO - [mozharness: 2017-05-10 19:03:04.063759Z] Running read-buildbot-config step. 12:03:04 INFO - Running pre-action listener: _resource_record_pre_action 12:03:04 INFO - Running main action method: read_buildbot_config 12:03:04 INFO - Using buildbot properties: 12:03:04 INFO - { 12:03:04 INFO - "project": "", 12:03:04 INFO - "product": "firefox", 12:03:04 INFO - "who": "ryanvm@gmail.com", 12:03:04 INFO - "installer_path": "public/build/target.tar.bz2", 12:03:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 12:03:04 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 12:03:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 12:03:04 INFO - "stage_platform": "linux64", 12:03:04 INFO - "basedir": "/builds/slave/test", 12:03:04 INFO - "buildnumber": 592, 12:03:04 INFO - "platform": "ubuntu64_hw", 12:03:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:03:04 INFO - "slavebuilddir": "test", 12:03:04 INFO - "taskId": "T-cV6s0ETZCBCue3BMIxcw", 12:03:04 INFO - "branch": "mozilla-central", 12:03:04 INFO - "script_repo_revision": "production", 12:03:04 INFO - "revision": "8a43b69fbae255a2af98f11507862437d6303033", 12:03:04 INFO - "slavename": "talos-linux64-ix-058", 12:03:04 INFO - "repo_path": "mozilla-central" 12:03:04 INFO - } 12:03:04 INFO - Finding installer, test and symbols from parent task. 12:03:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-cV6s0ETZCBCue3BMIxcw'}, attempt #1 12:03:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-cV6s0ETZCBCue3BMIxcw'}, attempt #1 12:03:04 INFO - Task dependencies: RzPACUvuQ3ahnxF0JMZTNw 12:03:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw'}, attempt #1 12:03:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.tar.bz2 12:03:05 INFO - Set test_url: https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/test_packages.json 12:03:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.crashreporter-symbols.zip 12:03:05 INFO - Running post-action listener: _resource_record_post_action 12:03:05 INFO - [mozharness: 2017-05-10 19:03:05.554496Z] Finished read-buildbot-config step (success) 12:03:05 INFO - [mozharness: 2017-05-10 19:03:05.554718Z] Running download-and-extract step. 12:03:05 INFO - Running pre-action listener: _resource_record_pre_action 12:03:05 INFO - Running main action method: download_and_extract 12:03:05 INFO - mkdir: /builds/slave/test/build/tests 12:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:05 INFO - trying https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.test_packages.json 12:03:05 INFO - Downloading https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:03:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:03:06 INFO - Downloaded 986 bytes. 12:03:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:03:06 INFO - Using the following test package requirements: 12:03:06 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:03:06 INFO - u'common': [u'target.common.tests.zip'], 12:03:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:03:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:03:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:03:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:03:06 INFO - u'mozbase': [u'target.common.tests.zip'], 12:03:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:03:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:03:06 INFO - u'web-platform': [u'target.common.tests.zip', 12:03:06 INFO - u'target.web-platform.tests.zip'], 12:03:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:03:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:03:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.common.tests.zip 12:03:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:03:06 INFO - Fetch https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.common.tests.zip into memory 12:03:07 INFO - Content-Length response header: 58595060 12:03:07 INFO - Bytes received: 58595060 12:03:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:03:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.common.tests.zip 12:03:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:03:17 INFO - Fetch https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.common.tests.zip into memory 12:03:18 INFO - Content-Length response header: 58595060 12:03:18 INFO - Bytes received: 58595060 12:03:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.talos.tests.zip 12:03:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:03:28 INFO - Fetch https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.talos.tests.zip into memory 12:03:29 INFO - Content-Length response header: 14409362 12:03:29 INFO - Bytes received: 14409362 12:03:29 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')]} 12:03:29 INFO - trying https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.tar.bz2 12:03:29 INFO - Downloading https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:03:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:03:31 INFO - Downloaded 63295273 bytes. 12:03:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.tar.bz2 12:03:31 INFO - mkdir: /builds/slave/test/properties 12:03:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:03:31 INFO - Writing to file /builds/slave/test/properties/build_url 12:03:31 INFO - Contents: 12:03:31 INFO - build_url:https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.tar.bz2 12:03:31 INFO - Running post-action listener: _resource_record_post_action 12:03:31 INFO - Running post-action listener: set_extra_try_arguments 12:03:31 INFO - [mozharness: 2017-05-10 19:03:31.107034Z] Finished download-and-extract step (success) 12:03:31 INFO - [mozharness: 2017-05-10 19:03:31.107132Z] Running populate-webroot step. 12:03:31 INFO - Running pre-action listener: _resource_record_pre_action 12:03:31 INFO - Running main action method: populate_webroot 12:03:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:03:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:03:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:03:31 INFO - '--tppagecycles', 12:03:31 INFO - '7'], 12:03:31 INFO - 'tests': ['tsvgm']}}, 12:03:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:03:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:03:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:03:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:03:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:03:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:03:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:03:31 INFO - 'talos_options': ['--disable-e10s'], 12:03:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:03:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:03:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:03:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:03:31 INFO - 'talos_options': ['--disable-e10s'], 12:03:31 INFO - 'tests': ['damp', 'tps']}, 12:03:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:03:31 INFO - 'tests': ['damp', 'tps']}, 12:03:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:03:31 INFO - 'tests': ['dromaeo_dom']}, 12:03:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:03:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:03:31 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 12:03:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:03:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:03:31 INFO - 'tests': ['a11yr', 12:03:31 INFO - 'ts_paint', 12:03:31 INFO - 'tpaint', 12:03:31 INFO - 'sessionrestore', 12:03:31 INFO - 'sessionrestore_no_auto_restore', 12:03:31 INFO - 'tabpaint']}, 12:03:31 INFO - 'other-e10s': {'tests': ['a11yr', 12:03:31 INFO - 'ts_paint', 12:03:31 INFO - 'tpaint', 12:03:31 INFO - 'sessionrestore', 12:03:31 INFO - 'sessionrestore_no_auto_restore', 12:03:31 INFO - 'tabpaint']}, 12:03:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:03:31 INFO - 'ts_paint', 12:03:31 INFO - 'tpaint', 12:03:31 INFO - 'sessionrestore', 12:03:31 INFO - 'sessionrestore_no_auto_restore', 12:03:31 INFO - 'tabpaint']}, 12:03:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:03:31 INFO - 'ts_paint', 12:03:31 INFO - 'tpaint', 12:03:31 INFO - 'sessionrestore', 12:03:31 INFO - 'sessionrestore_no_auto_restore', 12:03:31 INFO - 'tabpaint']}, 12:03:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:03:31 INFO - 'tests': ['a11yr', 12:03:31 INFO - 'ts_paint', 12:03:31 INFO - 'tpaint', 12:03:31 INFO - 'sessionrestore', 12:03:31 INFO - 'sessionrestore_no_auto_restore', 12:03:31 INFO - 'tabpaint']}, 12:03:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:03:31 INFO - 'tests': ['a11yr', 12:03:31 INFO - 'ts_paint', 12:03:31 INFO - 'tpaint', 12:03:31 INFO - 'sessionrestore', 12:03:31 INFO - 'sessionrestore_no_auto_restore', 12:03:31 INFO - 'tabpaint']}, 12:03:31 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 12:03:31 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 12:03:31 INFO - 'bloom_basic_ref']}, 12:03:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:03:31 INFO - 'tests': ['tsvgx', 12:03:31 INFO - 'tsvgr_opacity', 12:03:31 INFO - 'tart', 12:03:31 INFO - 'tscrollx', 12:03:31 INFO - 'cart', 12:03:31 INFO - 'tsvg_static']}, 12:03:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:03:31 INFO - 'tsvgr_opacity', 12:03:31 INFO - 'tart', 12:03:31 INFO - 'tscrollx', 12:03:31 INFO - 'cart', 12:03:31 INFO - 'tsvg_static']}, 12:03:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:03:31 INFO - 'talos_options': ['--disable-e10s'], 12:03:31 INFO - 'tests': ['tp5o']}, 12:03:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:03:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:03:31 INFO - 'talos_options': ['--disable-e10s', 12:03:31 INFO - '--xperf_path', 12:03:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:03:31 INFO - 'tests': ['tp5n']}, 12:03:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:03:31 INFO - 'talos_options': ['--xperf_path', 12:03:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:03:31 INFO - 'tests': ['tp5n']}}, 12:03:31 INFO - 'talos.zip': {'path': '', 12:03:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:03:31 INFO - Running post-action listener: _resource_record_post_action 12:03:31 INFO - [mozharness: 2017-05-10 19:03:31.120841Z] Finished populate-webroot step (success) 12:03:31 INFO - [mozharness: 2017-05-10 19:03:31.120931Z] Running create-virtualenv step. 12:03:31 INFO - Running pre-action listener: _resource_record_pre_action 12:03:31 INFO - Running main action method: create_virtualenv 12:03:31 INFO - Creating virtualenv /builds/slave/test/build/venv 12:03:31 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 12:03:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:03:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:03:31 INFO - Using real prefix '/usr' 12:03:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:03:31 INFO - Installing distribute.............................................................................................................................................................................................done. 12:03:33 INFO - Installing pip.................done. 12:03:33 INFO - Return code: 0 12:03:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:03:33 INFO - Reading from file tmpfile_stdout 12:03:33 INFO - Output received: 12:03:33 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) 12:03:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:33 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 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e51a30>, '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 0x1e527f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e52ca0>, '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': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', '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 12:03:33 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 12:03:33 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 12:03:33 INFO - Using env: {'DISPLAY': ':0', 12:03:33 INFO - 'HOME': '/home/cltbld', 12:03:33 INFO - 'LANG': 'en_US.UTF-8', 12:03:33 INFO - 'LANGUAGE': 'en_US:en', 12:03:33 INFO - 'LOGNAME': 'cltbld', 12:03:33 INFO - 'MAIL': '/var/mail/cltbld', 12:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:33 INFO - 'MOZ_NO_REMOTE': '1', 12:03:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:33 INFO - 'NO_EM_RESTART': '1', 12:03:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:33 INFO - 'PWD': '/builds/slave/test', 12:03:33 INFO - 'SHELL': '/bin/bash', 12:03:33 INFO - 'SHLVL': '1', 12:03:33 INFO - 'TERM': 'linux', 12:03:33 INFO - 'TMOUT': '86400', 12:03:33 INFO - 'USER': 'cltbld', 12:03:33 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', 12:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:33 INFO - '_': '/tools/buildbot/bin/python'} 12:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:34 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 12:03:34 INFO - Cleaning up... 12:03:34 INFO - Return code: 0 12:03:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e51a30>, '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 0x1e527f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e52ca0>, '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': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', '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 12:03:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:03:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:03:34 INFO - Using env: {'DISPLAY': ':0', 12:03:34 INFO - 'HOME': '/home/cltbld', 12:03:34 INFO - 'LANG': 'en_US.UTF-8', 12:03:34 INFO - 'LANGUAGE': 'en_US:en', 12:03:34 INFO - 'LOGNAME': 'cltbld', 12:03:34 INFO - 'MAIL': '/var/mail/cltbld', 12:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:34 INFO - 'MOZ_NO_REMOTE': '1', 12:03:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:34 INFO - 'NO_EM_RESTART': '1', 12:03:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:34 INFO - 'PWD': '/builds/slave/test', 12:03:34 INFO - 'SHELL': '/bin/bash', 12:03:34 INFO - 'SHLVL': '1', 12:03:34 INFO - 'TERM': 'linux', 12:03:34 INFO - 'TMOUT': '86400', 12:03:34 INFO - 'USER': 'cltbld', 12:03:34 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', 12:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:34 INFO - '_': '/tools/buildbot/bin/python'} 12:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:34 INFO - Downloading/unpacking psutil>=3.1.1 12:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:03:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:03:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:03:35 INFO - Installing collected packages: psutil 12:03:35 INFO - Running setup.py install for psutil 12:03:35 INFO - building 'psutil._psutil_linux' extension 12:03:35 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 12:03:35 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 12:03:35 INFO - building 'psutil._psutil_posix' extension 12:03:35 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 12:03:35 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 12:03:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:03:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:03:36 INFO - Successfully installed psutil 12:03:36 INFO - Cleaning up... 12:03:36 INFO - Return code: 0 12:03:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e51a30>, '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 0x1e527f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e52ca0>, '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': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', '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 12:03:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:03:36 INFO - Using env: {'DISPLAY': ':0', 12:03:36 INFO - 'HOME': '/home/cltbld', 12:03:36 INFO - 'LANG': 'en_US.UTF-8', 12:03:36 INFO - 'LANGUAGE': 'en_US:en', 12:03:36 INFO - 'LOGNAME': 'cltbld', 12:03:36 INFO - 'MAIL': '/var/mail/cltbld', 12:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:36 INFO - 'MOZ_NO_REMOTE': '1', 12:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:36 INFO - 'NO_EM_RESTART': '1', 12:03:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:36 INFO - 'PWD': '/builds/slave/test', 12:03:36 INFO - 'SHELL': '/bin/bash', 12:03:36 INFO - 'SHLVL': '1', 12:03:36 INFO - 'TERM': 'linux', 12:03:36 INFO - 'TMOUT': '86400', 12:03:36 INFO - 'USER': 'cltbld', 12:03:36 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', 12:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:36 INFO - '_': '/tools/buildbot/bin/python'} 12:03:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:03:36 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 12:03:36 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 12:03:36 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 12:03:36 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 12:03:36 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 12:03:36 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 12:03:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:03:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:03:37 INFO - Installing collected packages: mozsystemmonitor 12:03:37 INFO - Running setup.py install for mozsystemmonitor 12:03:37 INFO - Successfully installed mozsystemmonitor 12:03:37 INFO - Cleaning up... 12:03:37 INFO - Return code: 0 12:03:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:37 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 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e51a30>, '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 0x1e527f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e52ca0>, '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': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', '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 12:03:37 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 12:03:37 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 12:03:37 INFO - Using env: {'DISPLAY': ':0', 12:03:37 INFO - 'HOME': '/home/cltbld', 12:03:37 INFO - 'LANG': 'en_US.UTF-8', 12:03:37 INFO - 'LANGUAGE': 'en_US:en', 12:03:37 INFO - 'LOGNAME': 'cltbld', 12:03:37 INFO - 'MAIL': '/var/mail/cltbld', 12:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:37 INFO - 'MOZ_NO_REMOTE': '1', 12:03:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:37 INFO - 'NO_EM_RESTART': '1', 12:03:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:37 INFO - 'PWD': '/builds/slave/test', 12:03:37 INFO - 'SHELL': '/bin/bash', 12:03:37 INFO - 'SHLVL': '1', 12:03:37 INFO - 'TERM': 'linux', 12:03:37 INFO - 'TMOUT': '86400', 12:03:37 INFO - 'USER': 'cltbld', 12:03:37 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', 12:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:37 INFO - '_': '/tools/buildbot/bin/python'} 12:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:37 INFO - Downloading/unpacking jsonschema==2.5.1 12:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:03:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:03:38 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 12:03:38 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 12:03:38 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 12:03:38 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 12:03:38 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 12:03:38 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 12:03:39 INFO - Downloading functools32-3.2.3-2.tar.gz 12:03:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:03:39 INFO - warning: no files found matching '*.txt' 12:03:39 INFO - no previously-included directories found matching 'build' 12:03:39 INFO - no previously-included directories found matching 'dist' 12:03:39 INFO - no previously-included directories found matching '.git*' 12:03:39 INFO - Installing collected packages: jsonschema, functools32 12:03:39 INFO - Running setup.py install for functools32 12:03:39 INFO - warning: no files found matching '*.txt' 12:03:39 INFO - no previously-included directories found matching 'build' 12:03:39 INFO - no previously-included directories found matching 'dist' 12:03:39 INFO - no previously-included directories found matching '.git*' 12:03:39 INFO - Successfully installed jsonschema functools32 12:03:39 INFO - Cleaning up... 12:03:39 INFO - Return code: 0 12:03:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e51a30>, '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 0x1e527f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e52ca0>, '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': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', '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 12:03:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:03:39 INFO - Using env: {'DISPLAY': ':0', 12:03:39 INFO - 'HOME': '/home/cltbld', 12:03:39 INFO - 'LANG': 'en_US.UTF-8', 12:03:39 INFO - 'LANGUAGE': 'en_US:en', 12:03:39 INFO - 'LOGNAME': 'cltbld', 12:03:39 INFO - 'MAIL': '/var/mail/cltbld', 12:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:39 INFO - 'MOZ_NO_REMOTE': '1', 12:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:39 INFO - 'NO_EM_RESTART': '1', 12:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:39 INFO - 'PWD': '/builds/slave/test', 12:03:39 INFO - 'SHELL': '/bin/bash', 12:03:39 INFO - 'SHLVL': '1', 12:03:39 INFO - 'TERM': 'linux', 12:03:39 INFO - 'TMOUT': '86400', 12:03:39 INFO - 'USER': 'cltbld', 12:03:39 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', 12:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:39 INFO - '_': '/tools/buildbot/bin/python'} 12:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:03:39 INFO - Cleaning up... 12:03:39 INFO - Return code: 0 12:03:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e51a30>, '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 0x1e527f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e52ca0>, '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': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', '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 12:03:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:03:39 INFO - Using env: {'DISPLAY': ':0', 12:03:39 INFO - 'HOME': '/home/cltbld', 12:03:39 INFO - 'LANG': 'en_US.UTF-8', 12:03:39 INFO - 'LANGUAGE': 'en_US:en', 12:03:39 INFO - 'LOGNAME': 'cltbld', 12:03:39 INFO - 'MAIL': '/var/mail/cltbld', 12:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:39 INFO - 'MOZ_NO_REMOTE': '1', 12:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:39 INFO - 'NO_EM_RESTART': '1', 12:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:39 INFO - 'PWD': '/builds/slave/test', 12:03:39 INFO - 'SHELL': '/bin/bash', 12:03:39 INFO - 'SHLVL': '1', 12:03:39 INFO - 'TERM': 'linux', 12:03:39 INFO - 'TMOUT': '86400', 12:03:39 INFO - 'USER': 'cltbld', 12:03:39 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', 12:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:39 INFO - '_': '/tools/buildbot/bin/python'} 12:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:39 INFO - Downloading/unpacking blobuploader==1.2.4 12:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:40 INFO - Downloading blobuploader-1.2.4.tar.gz 12:03:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:03:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:03:41 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 12:03:41 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 12:03:41 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 12:03:41 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 12:03:41 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 12:03:41 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 12:03:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:03:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:03:41 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 12:03:41 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 12:03:41 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 12:03:41 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 12:03:41 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 12:03:41 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 12:03:41 INFO - Downloading docopt-0.6.1.tar.gz 12:03:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:03:41 INFO - Installing collected packages: blobuploader, requests, docopt 12:03:41 INFO - Running setup.py install for blobuploader 12:03:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:03:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:03:41 INFO - Running setup.py install for requests 12:03:42 INFO - Running setup.py install for docopt 12:03:42 INFO - Successfully installed blobuploader requests docopt 12:03:42 INFO - Cleaning up... 12:03:42 INFO - Return code: 0 12:03:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12: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')]} 12:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:42 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 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e51a30>, '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 0x1e527f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e52ca0>, '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': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', '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 12:03:42 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 12:03:42 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 12:03:42 INFO - Using env: {'DISPLAY': ':0', 12:03:42 INFO - 'HOME': '/home/cltbld', 12:03:42 INFO - 'LANG': 'en_US.UTF-8', 12:03:42 INFO - 'LANGUAGE': 'en_US:en', 12:03:42 INFO - 'LOGNAME': 'cltbld', 12:03:42 INFO - 'MAIL': '/var/mail/cltbld', 12:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:42 INFO - 'MOZ_NO_REMOTE': '1', 12:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:42 INFO - 'NO_EM_RESTART': '1', 12:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:42 INFO - 'PWD': '/builds/slave/test', 12:03:42 INFO - 'SHELL': '/bin/bash', 12:03:42 INFO - 'SHLVL': '1', 12:03:42 INFO - 'TERM': 'linux', 12:03:42 INFO - 'TMOUT': '86400', 12:03:42 INFO - 'USER': 'cltbld', 12:03:42 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', 12:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:42 INFO - '_': '/tools/buildbot/bin/python'} 12:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:03:42 INFO - Running setup.py (path:/tmp/pip-Dx2vw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:03:42 INFO - Running setup.py (path:/tmp/pip-vPBeSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:03:42 INFO - Running setup.py (path:/tmp/pip-HMUF9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:03:42 INFO - Running setup.py (path:/tmp/pip-wOYU7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:03:42 INFO - Running setup.py (path:/tmp/pip-9taB4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:03:42 INFO - Running setup.py (path:/tmp/pip-i97SFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:03:42 INFO - Running setup.py (path:/tmp/pip-W6XT8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:03:42 INFO - Running setup.py (path:/tmp/pip-oiBQUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:03:43 INFO - Running setup.py (path:/tmp/pip-CBcxx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:03:43 INFO - Running setup.py (path:/tmp/pip-vBrD6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:03:43 INFO - Running setup.py (path:/tmp/pip-xJ7BTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:03:43 INFO - Running setup.py (path:/tmp/pip-uhQDw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:03:43 INFO - Running setup.py (path:/tmp/pip-X0wNSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:03:43 INFO - Running setup.py (path:/tmp/pip-GLUv_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:43 INFO - Running setup.py (path:/tmp/pip-eBBRJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:03:43 INFO - Running setup.py (path:/tmp/pip-k7Ymlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:03:43 INFO - Running setup.py (path:/tmp/pip-3iyGVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:03:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:03:43 INFO - Running setup.py install for manifestparser 12:03:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:03:43 INFO - Running setup.py install for mozcrash 12:03:43 INFO - Running setup.py install for mozdebug 12:03:43 INFO - Running setup.py install for mozdevice 12:03:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Running setup.py install for mozfile 12:03:44 INFO - Running setup.py install for mozhttpd 12:03:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Running setup.py install for mozinfo 12:03:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Running setup.py install for mozInstall 12:03:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Running setup.py install for mozleak 12:03:44 INFO - Running setup.py install for mozlog 12:03:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Running setup.py install for moznetwork 12:03:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Running setup.py install for mozprocess 12:03:44 INFO - Running setup.py install for mozprofile 12:03:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:03:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:03:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:03:45 INFO - Running setup.py install for mozrunner 12:03:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:03:45 INFO - Running setup.py install for mozscreenshot 12:03:45 INFO - Running setup.py install for moztest 12:03:45 INFO - Running setup.py install for mozversion 12:03:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:03:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:03:45 INFO - Cleaning up... 12:03:45 INFO - Return code: 0 12:03:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12: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')]} 12:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:45 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 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e51a30>, '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 0x1e527f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e52ca0>, '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': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', '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 12:03:45 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 12:03:45 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 12:03:45 INFO - Using env: {'DISPLAY': ':0', 12:03:45 INFO - 'HOME': '/home/cltbld', 12:03:45 INFO - 'LANG': 'en_US.UTF-8', 12:03:45 INFO - 'LANGUAGE': 'en_US:en', 12:03:45 INFO - 'LOGNAME': 'cltbld', 12:03:45 INFO - 'MAIL': '/var/mail/cltbld', 12:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:45 INFO - 'MOZ_NO_REMOTE': '1', 12:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:45 INFO - 'NO_EM_RESTART': '1', 12:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:45 INFO - 'PWD': '/builds/slave/test', 12:03:45 INFO - 'SHELL': '/bin/bash', 12:03:45 INFO - 'SHLVL': '1', 12:03:45 INFO - 'TERM': 'linux', 12:03:45 INFO - 'TMOUT': '86400', 12:03:45 INFO - 'USER': 'cltbld', 12:03:45 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', 12:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:45 INFO - '_': '/tools/buildbot/bin/python'} 12:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:03:45 INFO - Running setup.py (path:/tmp/pip-HbyBqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:03:45 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)) 12:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:03:45 INFO - Running setup.py (path:/tmp/pip-sbInzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:03:45 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)) 12:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:03:45 INFO - Running setup.py (path:/tmp/pip-dQesT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:03:45 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)) 12:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:03:45 INFO - Running setup.py (path:/tmp/pip-5OhnX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 12:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:03:45 INFO - Running setup.py (path:/tmp/pip-PEw06k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:03:46 INFO - Running setup.py (path:/tmp/pip-iaEjHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:03:46 INFO - Running setup.py (path:/tmp/pip-__4FKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:03:46 INFO - Running setup.py (path:/tmp/pip-9RQQKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:03:46 INFO - Running setup.py (path:/tmp/pip-WcNaJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:03:46 INFO - Running setup.py (path:/tmp/pip-31PVsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:03:46 INFO - Running setup.py (path:/tmp/pip-51JArM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:03:46 INFO - Running setup.py (path:/tmp/pip-fZglhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:03:46 INFO - Running setup.py (path:/tmp/pip-0ZtFzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:03:46 INFO - Running setup.py (path:/tmp/pip-AP4aCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:46 INFO - Running setup.py (path:/tmp/pip-Sb2XJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:03:46 INFO - Running setup.py (path:/tmp/pip-AD3Ktr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:03:46 INFO - Running setup.py (path:/tmp/pip-BHSJQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:03:46 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)) 12:03:46 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)) 12:03:46 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)) 12:03:46 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)) 12:03:46 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:03:46 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:03:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:03:46 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 12:03:46 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 12:03:46 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 12:03:46 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 12:03:46 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 12:03:46 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 12:03:48 INFO - Downloading blessings-1.6.tar.gz 12:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:03:48 INFO - Installing collected packages: blessings 12:03:48 INFO - Running setup.py install for blessings 12:03:48 INFO - Successfully installed blessings 12:03:48 INFO - Cleaning up... 12:03:48 INFO - Return code: 0 12:03:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:03:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:03:48 INFO - Reading from file tmpfile_stdout 12:03:48 INFO - Current package versions: 12:03:48 INFO - argparse == 1.2.1 12:03:48 INFO - blessings == 1.6 12:03:48 INFO - blobuploader == 1.2.4 12:03:48 INFO - docopt == 0.6.1 12:03:48 INFO - functools32 == 3.2.3-2 12:03:48 INFO - jsonschema == 2.5.1 12:03:48 INFO - manifestparser == 1.1 12:03:48 INFO - mozInstall == 1.12 12:03:48 INFO - mozcrash == 1.0 12:03:48 INFO - mozdebug == 0.1 12:03:48 INFO - mozdevice == 0.50 12:03:48 INFO - mozfile == 1.2 12:03:48 INFO - mozhttpd == 0.7 12:03:48 INFO - mozinfo == 0.9 12:03:48 INFO - mozleak == 0.1 12:03:48 INFO - mozlog == 3.4 12:03:48 INFO - moznetwork == 0.27 12:03:48 INFO - mozprocess == 0.25 12:03:48 INFO - mozprofile == 0.28 12:03:48 INFO - mozrunner == 6.13 12:03:48 INFO - mozscreenshot == 0.1 12:03:48 INFO - mozsystemmonitor == 0.3 12:03:48 INFO - moztest == 0.8 12:03:48 INFO - mozversion == 1.4 12:03:48 INFO - psutil == 3.1.1 12:03:48 INFO - requests == 1.2.3 12:03:48 INFO - wsgiref == 0.1.2 12:03:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12: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')]} 12:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:48 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 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e51a30>, '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 0x1e527f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e52ca0>, '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': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', '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 12:03:48 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 12:03:48 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 12:03:48 INFO - Using env: {'DISPLAY': ':0', 12:03:48 INFO - 'HOME': '/home/cltbld', 12:03:48 INFO - 'LANG': 'en_US.UTF-8', 12:03:48 INFO - 'LANGUAGE': 'en_US:en', 12:03:48 INFO - 'LOGNAME': 'cltbld', 12:03:48 INFO - 'MAIL': '/var/mail/cltbld', 12:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:48 INFO - 'MOZ_NO_REMOTE': '1', 12:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:48 INFO - 'NO_EM_RESTART': '1', 12:03:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:48 INFO - 'PWD': '/builds/slave/test', 12:03:48 INFO - 'SHELL': '/bin/bash', 12:03:48 INFO - 'SHLVL': '1', 12:03:48 INFO - 'TERM': 'linux', 12:03:48 INFO - 'TMOUT': '86400', 12:03:48 INFO - 'USER': 'cltbld', 12:03:48 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', 12:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:48 INFO - '_': '/tools/buildbot/bin/python'} 12:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:48 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)) 12:03:48 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)) 12:03:48 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)) 12:03:48 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)) 12:03:48 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)) 12:03:48 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)) 12:03:48 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)) 12:03:48 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)) 12:03:48 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)) 12:03:48 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)) 12:03:48 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)) 12:03:48 INFO - Cleaning up... 12:03:48 INFO - Return code: 0 12:03:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12: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')]} 12:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e51a30>, '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 0x1e527f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e52ca0>, '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': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', '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 12: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'] in /builds/slave/test/build 12: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 12:03:48 INFO - Using env: {'DISPLAY': ':0', 12:03:48 INFO - 'HOME': '/home/cltbld', 12:03:48 INFO - 'LANG': 'en_US.UTF-8', 12:03:48 INFO - 'LANGUAGE': 'en_US:en', 12:03:48 INFO - 'LOGNAME': 'cltbld', 12:03:48 INFO - 'MAIL': '/var/mail/cltbld', 12:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:48 INFO - 'MOZ_NO_REMOTE': '1', 12:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:48 INFO - 'NO_EM_RESTART': '1', 12:03:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:48 INFO - 'PWD': '/builds/slave/test', 12:03:48 INFO - 'SHELL': '/bin/bash', 12:03:48 INFO - 'SHLVL': '1', 12:03:48 INFO - 'TERM': 'linux', 12:03:48 INFO - 'TMOUT': '86400', 12:03:48 INFO - 'USER': 'cltbld', 12:03:48 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', 12:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:48 INFO - '_': '/tools/buildbot/bin/python'} 12:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:03:48 INFO - Cleaning up... 12:03:48 INFO - Return code: 0 12:03:48 INFO - Running post-action listener: _resource_record_post_action 12:03:48 INFO - Running post-action listener: _start_resource_monitoring 12:03:48 INFO - Starting resource monitoring. 12:03:48 INFO - [mozharness: 2017-05-10 19:03:48.985312Z] Finished create-virtualenv step (success) 12:03:48 INFO - [mozharness: 2017-05-10 19:03:48.985952Z] Running install step. 12:03:48 INFO - Running pre-action listener: _resource_record_pre_action 12:03:48 INFO - Running main action method: install 12:03:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:03:49 INFO - Reading from file tmpfile_stdout 12:03:49 INFO - Detecting whether we're running mozinstall >=1.0... 12:03:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:03:49 INFO - Reading from file tmpfile_stdout 12:03:49 INFO - Output received: 12:03:49 INFO - Usage: mozinstall [options] installer 12:03:49 INFO - Options: 12:03:49 INFO - -h, --help show this help message and exit 12:03:49 INFO - -d DEST, --destination=DEST 12:03:49 INFO - Directory to install application into. [default: 12:03:49 INFO - "/builds/slave/test"] 12:03:49 INFO - --app=APP Application being installed. [default: firefox] 12:03:49 INFO - mkdir: /builds/slave/test/build/application 12:03:49 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'] 12:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:04:05 INFO - Reading from file tmpfile_stdout 12:04:05 INFO - Output received: 12:04:05 INFO - /builds/slave/test/build/application/firefox/firefox 12:04:05 INFO - Running post-action listener: _resource_record_post_action 12:04:05 INFO - [mozharness: 2017-05-10 19:04:05.293558Z] Finished install step (success) 12:04:05 INFO - [mozharness: 2017-05-10 19:04:05.293893Z] Running run-tests step. 12:04:05 INFO - Running pre-action listener: _resource_record_pre_action 12:04:05 INFO - Running main action method: run_tests 12:04:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:04:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:04:05 INFO - Python 2.7.3 12:04:05 INFO - Return code: 0 12:04:05 INFO - grabbing minidump binary from tooltool 12:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:04:05 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 0x1e51a30>, '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 0x1e527f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e52ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:04:05 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 12:04:05 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 12:04:05 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 12:04:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:04:05 INFO - Return code: 0 12:04:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:04:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:04:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:04:05 INFO - ENV: RUST_BACKTRACE is now 1 12:04:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:04:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:04:05 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:04:05 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:04:05 INFO - Using env: {'DISPLAY': ':0', 12:04:05 INFO - 'HOME': '/home/cltbld', 12:04:05 INFO - 'LANG': 'en_US.UTF-8', 12:04:05 INFO - 'LANGUAGE': 'en_US:en', 12:04:05 INFO - 'LOGNAME': 'cltbld', 12:04:05 INFO - 'MAIL': '/var/mail/cltbld', 12:04:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:04:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:04:05 INFO - 'MOZ_NO_REMOTE': '1', 12:04:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:04:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:04:05 INFO - 'NO_EM_RESTART': '1', 12:04:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:04:05 INFO - 'PWD': '/builds/slave/test', 12:04:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:04:05 INFO - 'RUST_BACKTRACE': '1', 12:04:05 INFO - 'SHELL': '/bin/bash', 12:04:05 INFO - 'SHLVL': '1', 12:04:05 INFO - 'TERM': 'linux', 12:04:05 INFO - 'TMOUT': '86400', 12:04:05 INFO - 'USER': 'cltbld', 12:04:05 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485', 12:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:04:05 INFO - '_': '/tools/buildbot/bin/python'} 12:04:05 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:04:05 INFO - mozversion application_buildid: 20170510181551 12:04:05 INFO - mozversion application_changeset: 8a43b69fbae255a2af98f11507862437d6303033 12:04:05 INFO - mozversion application_display_name: Nightly 12:04:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:04:05 INFO - mozversion application_name: Firefox 12:04:05 INFO - mozversion application_remotingname: firefox 12:04:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:04:05 INFO - mozversion application_vendor: Mozilla 12:04:05 INFO - mozversion application_version: 55.0a1 12:04:05 INFO - mozversion platform_buildid: 20170510181551 12:04:05 INFO - mozversion platform_changeset: 8a43b69fbae255a2af98f11507862437d6303033 12:04:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:04:05 INFO - mozversion platform_version: 55.0a1 12:04:05 INFO - using testdate: 1494443045 12:04:05 INFO - actual date: 1494443045 12:04:05 INFO - starting webserver on 'localhost:37490' 12:04:05 INFO - SUITE-START | Running 2 tests 12:04:05 INFO - TEST-START | dromaeo_css 12:04:05 INFO - operating with platform_type : linux_ 12:04:05 INFO - Initialising browser for dromaeo_css test... 12:04:05 INFO - TEST-INFO | started process 30943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNXwnB8/profile http://localhost:37490/getInfo.html) 12:04:09 INFO - PID 30943 | __metrics Screen width/height:1600/1200 12:04:09 INFO - PID 30943 | colorDepth:24 12:04:09 INFO - PID 30943 | Browser inner width/height: 1024/695 12:04:09 INFO - PID 30943 | __metrics 12:04:11 INFO - TEST-INFO | 30943: exit 0 12:04:11 INFO - Browser initialized. 12:04:11 INFO - Running cycle 1/1 for dromaeo_css test... 12:04:11 INFO - TEST-INFO | started process 31115 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNXwnB8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:04:23 INFO - PID 31115 | RSS: Main: 155279360 12:04:23 INFO - PID 31115 | 12:07:28 INFO - PID 31115 | Cycle 1(1): loaded http://localhost:37490/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37490/tests/dromaeo/cssquery-ext.html) 12:07:31 INFO - PID 31115 | RSS: Main: 166346752 12:07:31 INFO - PID 31115 | 12:10:33 INFO - PID 31115 | Cycle 1(1): loaded http://localhost:37490/tests/dromaeo/cssquery-ext.html (next: http://localhost:37490/tests/dromaeo/cssquery-jquery.html) 12:10:34 INFO - PID 31115 | RSS: Main: 160354304 12:10:34 INFO - PID 31115 | 12:13:36 INFO - PID 31115 | Cycle 1(1): loaded http://localhost:37490/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37490/tests/dromaeo/cssquery-mootools.html) 12:13:37 INFO - PID 31115 | RSS: Main: 170491904 12:13:37 INFO - PID 31115 | 12:16:38 INFO - PID 31115 | Cycle 1(1): loaded http://localhost:37490/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37490/tests/dromaeo/cssquery-prototype.html) 12:16:39 INFO - PID 31115 | RSS: Main: 160604160 12:16:39 INFO - PID 31115 | 12:19:42 INFO - PID 31115 | Cycle 1(1): loaded http://localhost:37490/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37490/tests/dromaeo/cssquery-yui.html) 12:19:43 INFO - PID 31115 | RSS: Main: 165199872 12:19:43 INFO - PID 31115 | 12:22:44 INFO - PID 31115 | Cycle 1(1): loaded http://localhost:37490/tests/dromaeo/cssquery-yui.html (next: http://localhost:37490/tests/dromaeo/cssquery-dojo.html) 12:22:45 INFO - PID 31115 | RSS: Main: 167878656 12:22:45 INFO - PID 31115 | 12:22:45 INFO - PID 31115 | __start_tp_report 12:22:45 INFO - PID 31115 | _x_x_mozilla_page_load 12:22:45 INFO - PID 31115 | _x_x_mozilla_page_load_details 12:22:45 INFO - PID 31115 | |i|pagename|runs| 12:22:45 INFO - PID 31115 | |0;dojo.html;2710;2722.7957903157244;2723.6731592208926;2740.8629568521574;2750.7111753265917;5179.689218646874;5279.3400824896935;5288.8413347599535;5295.894082118355;5303.57571394288;5214.973925130378;5260.605454590902;5263.3683957925105;5360.383555891074;5400.648957817739;4413.845515406962;4667.172160587438;4707.917179048821;4751.667383283171;4798.712077275374;4780.976095119519;4805.567498925096;4852;4857.465678775332;4870.147724148278;4655.185342565038;4697.812087516495;4723.149833030053;4736.123817093849;4763.261694437333;4594.356790049395;4631.8378856739855;4669.41632295963;4716.716996980158;4733.171694953369;4581.541845815425;4593.035462552868;4607.14767767964;4639.072185562901;4662.743549104798;5176.2235664650225;5177.171652535614;5204.063268611649;5209.895802083975;5216.7913283468615;5554.389017208104;5567.638103523258;5624.775008999635;5724.341700704389;5762.366139724627;5714.114312281561;5762.510186634141;5770.394108618619;5771.913421298684;5808.070708686632;5295.788168473295;5297.364316282071;5315.989961907225;5319.255304257407;5321.281626980385;5772.653640781483;5845.386234445407;5861.677607731531;5869.178315035899;5878.970605147032;5452.618316717871;5480.232767412565;5530.170474428868;5535.308086489189;5550.555955523549;5676.403977582295;5682.687452190169;5691.573132015115;5699.715014249271;5706.28671416073;5631.465010823965;5641.830745077655;5653.858653533694;5663.348714897757;5667.716614169358;5644;5673.602847800615;5681.744321505542;5682.801101961411;5690.715464226772;4787.928181077286;4790.473047964721;4796.232602783608;4804.06320767447;4806.375171227788;3974.8807535773394;4149.439825623563;4154.937675934863;4164.646005089541;4172.7913604319665;4922.187839006524;4925.1873440881855;4928.137575924199;4931.0630980113665;4961.900761984813;5781.046127388934;5795.94204057954;5803;5806.274215723035;5855.853603659943;4809.5430934061205;4880.82917097907;4881.414230292387;4900.950990490121;4909.656324057353;5038.823641172541;5125.256837758504;5149.073166830007;5151.8196863109615;5152.76812543429;5303.045451818555;5319.547838433777;5326.307580014573;5328.067588171977;5336.306280183707;5703.600747947604;5733;5747.827565173052;5796.478316951495;5822.417758224144;5284.577233821208;5345.198220266836;5349.411564727799;5352.866178345573;5380.542653874464;5640.407757185437;5648.802291919763;5670.574706896917;5681.9431805681415;5730.426957304237;5577.972110139423;5644.717764111861;5667.149927510906;5679.77280908759;5768.769249229984;5466.043442397644;5469.288992430958;5470.480304371078;5478.096114141282;5478.890422191614;5396.298481197577;5440.4015558287765;5461.563074953915;5470.179473078911;5473.534749546333;5379.381371142369;5393.244945707525;5399.2980912481125;5399.487048730364;5399.83800485986;5460.208269800777;5476.835694929158;5574.804881829116;5654.745536450787;5676.233708449472;5458.890822183614;5463.562914966873;5464.726763661881;5466.316710411199;5473.28847249855 12:22:45 INFO - PID 31115 | |1;ext.html;703.1527009953007;1037.3879411147423;1049.8687664041995;1154.2382027861613;1165.2076587920221;29081.70918290819;30043.549346759817;30060.248493787665;30061;30082.247943801416;28449.146525604265;28766;28845.423091538156;28846;28960;6285.4971602271935;6317.210348706411;6902.344277293674;6925.134358205224;6926.965365173167;6654.800355989304;6709.429698475636;6721.966390168042;6726;6735.259121496631;6632.1709786276715;6705.865882682343;6750;6752.493562982771;6760.729570817161;6695.765648202289;6702.530822842403;6704.564203326768;6736.292689267605;6756.391924726749;6824.965875170642;6825.863482730318;6832.795016149524;6851;6866;30122;30168.698313017027;30195.245118871986;30277.848610756806;30323.545146822817;3066.693330666938;3099.271671157276;3106.1923899785993;3118.8908388206532;3123.172359324758;23418.648720269208;23546.529069418517;23569.76430235693;23595.646065309033;23636.76363236363;3166.3825554016976;3182.0771976126894;3193.281511659858;3212.518122281653;3212.775105742599;139124.30437847847;139893;139946.30026849904;140055.29972350074;140211.29894350565;36001.45997810035;37934.46474543206;37959.4306085409;38056.238875222894;38061.429078563844;39395.606043939195;39472.802635986634;39592.60407395947;39722.20555588872;39841.40237896434;11433.485493152828;11459.083273338112;11550.88449115515;11600.593979210687;11619.941900290445;9143.54282285883;9148.496832674135;9192;9244.121808428188;9287.953560232156;11991.580294689818;12064;12127.878721212675;12137.271763694207;12266.141370104186;5114.43741188469;5163;5178.71517066565;5198.544407565888;5213.244079608436;870.6473878079262;897.4749771383683;905.3164860530258;906.9388815086234;935.2938531408743;19899.60200795976;20725.58548829015;20847.687284690743;21052.36842894685;21140;956.4691596164057;962.5620342744035;970.6990832841842;981.9558119884622;998.9100980911753;10239.18086553074;10841.18691098155;11022.50398732059;11172.10623150146;11188.440577971069;164409;166346;166805.16597417177;167008;167491;38007.239855202744;38423.423648645294;38492;38537.80731096383;38540;1182.869884312725;1202.5189924030283;1214.0469731261094;1214.4352875912743;1233.0875152387168;19092.23631054742;19437;20038.298659546846;20309.49226269355;20470.79529204689;26475.735242648097;26533.469330612894;26608.33479162959;26616.201513954613;26681.599776002986;137166;138550;139259;139278.3036084813;139393;27183.86408068026;27588.724112758617;27937.44125117527;28442.43115137727;29133.417331653673;34224;34778.652213478555;35004;35174.29651407008;35181.82409087938;26326.86836565805;26646.20061398161;26776.46447071009;26885.865570672802;27691;26096.478070438865;26676.466470670865;27094.593581095905;27446.862765686044;27622.861885690443;28478.43043139167;29353.706462935952;29645.703542964293;29658.40683186281;29878;25610.35974100588;26121.869390653686;26711.866440667673;27089.86455067712;27161.049363272192;20231.393058208276;22051.558968820853;22359.21742738996;22382.104715811187;22391.328260152222 12:22:45 INFO - PID 31115 | |2;jquery.html;408.96932730045256;415.0517867126572;426.0860454325473;443.7204561126492;444.20709034373647;15873.444429444971;16467.423640172598;17120.914395428023;17166.22751976161;17873.731894021566;16668.16659167043;17202.225899834506;17333.653326933454;18023.36918207863;18295.268189272414;5439.646422982513;5480.972595137018;5482.588805839578;5554.1946417769395;5586.776528938837;5420.5934554908345;5488.7530061147145;5494.5054945054935;5500.22996780451;5519.586031047667;5267.23625074364;5437.477506298243;5472.179173124044;5523.061079616455;5534.363548191969;5400.054990376688;5436.891262174754;5467.753951072172;5484;5506.531944784698;4764.190087685067;4891.804327826882;4914.213725803854;4942.752862356868;4946.3817022872145;22103.226387076375;22140.2250921217;22345.664815027787;23059.423514412105;23115.76884231153;1600.1519194826644;1638.0990455249685;1657.966840663192;1666.7749853769708;1680.0591668665586;14563.781543276858;14832.555023349316;15108.622284442867;15149.924250378788;15327.157006364645;2093.5080256139795;2119.395972147946;2163.707899433572;2179.6403593407067;2193.243331050785;81855.5907220466;86239;88640;95593.52203239009;96129.51935240348;10603.89396106029;11044.33733975964;11257.380844053656;11270.267432616854;11887.227330223508;15478.767818482731;15551.611209719847;15555.22223888801;15567.610809729847;15615.939855637616;7162.0920280842865;7255.836183591382;7325.733693892826;7365.373943214887;7431.142214446389;6496.090547323379;6708.463322934153;6761.4590832733265;6883.414909732629;6949.200841903245;7058.788236352918;7090.6100164491445;7099.538529995534;7178.892316615255;7236.819079523054;2042.4179108953876;2066.5970135823673;2091.7699053104147;2092.6547119725074;2185.715856938588;811.3752410643772;856.1310270075753;861.6251930410292;864.8097418567905;875.1336177184542;17235.482935511955;17482.388116415863;17738.5565360867;17985.514418102342;18026.819731802778;850.4897061763016;856.6102423397339;859.3769517100052;863.4560227056913;868.079835374505;9540.093691099335;9631.951840240754;9898.851517227247;9918.851217231748;10026.64906728261;338576;341771;344786;346045;354663;68039.65980170068;71036;71552.2844771556;72716;73535;997.4165113408592;1024.4519182237468;1050.5167622893402;1056.4136904018344;1056.4400867540216;14696;14798.77801832995;15029.398824047354;15032.398704052153;15485;37429;37496;37792.43311350277;37801.62198377981;38682.22635547329;46079.76960115178;46127.76936115298;46450.76774616105;46605.368812091416;47972.520274798204;8022.598870056357;8166.183381661786;8233.917660823316;8236.588170591567;8566.271866891135;11980.400979951142;12894;13288.734225315633;13546.119502232323;13602.455901763818;11005.229633925548;11160.776784464102;11395;11574.6527604172;11801.881981180079;8710.433821801562;8897.199252067345;9517.904820951979;9837.311388202757;9859.30984831055;11346.659600212008;11400.48697808584;11424.143189261005;11730.178887477794;11891.702707432383;8290.377578591813;8385;8428.160933850717;8558.828823423371;8646.870296945677;9692.321537492307;9829.606815727291;9918.702438926844;10169.593216271267;11117.610883619358 12:22:45 INFO - PID 31115 | |3;mootools.html;1219.1892391559613;1276.4702648400914;1279.878411550903;1281.2632736176702;1283.7111649878777;9766.609335626576;10204.489775511232;10213.693589192328;10398.116160126398;10628.46857657116;10414.531346089425;10548.419836908966;10578.471076446185;10591.205659575524;10628.256022078458;2203.592335417949;2241.663750437431;2250.516139030108;2251.7410497792716;2259.954800903981;1976.10087410228;2016.5462770876509;2018.6669199582052;2023.4738967868313;2023.959520809583;2204.64725643897;2238;2244.057495851738;2262.8189744820456;2281.178775640768;2140.2509121807398;2190.8356873234493;2196.681481185235;2201.2845825106824;2208.3595757230382;1874.681304178293;1999.1503610965426;2006.0671787618828;2128.053016407699;2158.6438237690763;10311.84532232017;10422.583096676124;10456.529456174414;10458.320209186379;10489.423081730578;5304.469553044703;5453.481919217668;5478.205660179252;5492.423295553989;5501.559875209973;3087.72210501056;3302.488114342281;3345.4312766829453;3366.208940898887;3429.725621950238;1059.973500662482;1082.377632861108;1099.7305660113323;1099.8955099265556;1107.545906178463;15265.694686106326;15281.235938203044;15400;15447.691046179127;15456.536303910902;4697.859064228079;4840.15297322967;5042.3444952156715;5088.236764485283;5099.515546023122;11010.339379637247;11027.944860275808;11046.33721976668;11069.169812264112;11074.612388566362;5354.170103633943;5358.705271210043;5374.167004114369;5391.083515802323;5412.296401467784;4895.559399654048;4919.852404427873;4920;5115.693058416507;5284.9471505284455;3789.2232092420986;3882.340596691219;3915.0799562102884;3937.3897045957924;3966.3852102924093;1124.651358078998;1132.6318946342471;1139.3733446604335;1146.4611632532697;1149.143887803575;586.1383765864173;594.9018411962064;595.1727099331932;599.179124599293;600.1328080923024;5053.267276244924;5114.795408183705;5119.0273847968765;5144.742762861842;5241.36139516523;541.182813950937;549.2228496677156;802.5024484819332;823.3125340340763;838.8112674648278;3616.3129005488872;3700.0564855961557;3753.324401607737;3815.503984482055;3846.4230365445405;13588.505264420906;13819.723605528034;14031.78952315716;14101.647458813406;14113.929430352782;13508.392122354519;13509;13692.794608080887;13736.587902362946;13763.174209547458;7373.5944523050675;7456.850862982818;7551.093868735677;7557.206493318233;7596.544207347577;5885.264341957255;5906.084556893688;5999.220101386792;6037.969810150921;6112.908306375319;12077.818832717692;12113.15207935436;12119;12235.204711693712;12247.203931744409;12375.071869609636;12409.44157512896;12427.378631068592;12448.25310481374;12592.87407125917;7582.62086895642;7694.653740581575;7708.03649543807;7757.224277572198;7761.223877612194;9731.367461115287;9782.364146330467;9806.313558050868;9813.264005199495;9836.704898853046;7999.9600001999615;8061.2744852963515;8142.592870356577;8143.5928203590765;8292.2951549119;7944.563049032358;7948.96663433773;7973.481723687942;8007.719729809429;8135.959320203598;7122.7507037253445;7144.892826607501;7153.678084486107;7238.6380680964685;7276.235995220637;5059.342285502861;5061.38787377887;5078.289039534542;5129.9743501282255;5213.687178769286;5182.766775495036;5255.13290307095;5323.30796996388;5341.465853414627;5380.730963451733 12:22:45 INFO - PID 31115 | |4;prototype.html;368.0779646984304;396.76590811421266;397.22937501247594;405.0622808199019;406.32752794125713;5554.722263886804;5604.691741954191;5605.103183490643;5610.410906854782;5622.634528755628;5457.754401051952;5474.343078830536;5477.424870388611;5482.150266708657;5485.61600687951;3906.355451350531;4053.5541090480024;4111.198316328318;4111.60939710727;4116.8970775730695;4090.1389867610314;4119.5880411958715;4124.443200167969;4139.2135494256145;4142.399352093945;4091.0590564170257;4092.4475195848627;4105.668519711703;4114.547399786021;4120.361343991671;4056.5132184137797;4081.265372232997;4083.1221287423346;4119.237940980913;4123.649489793371;3560.4481305397703;3585.695215906651;3587.0494319005484;3587.0852932502044;3592.5329707138167;5335.653182543161;5346.732663366816;5357.383900851413;5362.276092727471;5368.812091576776;4779.569838714498;4814.927776083362;4828.5654291113615;4834.58905992991;4849.709017458928;5722.685252311121;5745.166950792153;5757.193992841006;5757.395473475309;5775.16260142277;4018.819153138116;4032.374981877784;4038.5759495253164;4039.1315867088715;4049.250888585621;5971.402859714038;6074.331823499411;6077.878442431127;6167.074938759177;6167.629942203482;4054.006768341775;4114.341705327133;4116.938245926313;4130.710850240514;4144.7513149210545;4173.2055216256695;4197.097624010852;4197.3074442717225;4197.958020419818;4201.768902710381;4722.291656251589;4792.161371759928;4802.718708613381;4824.517548245148;4837.975810120927;5691.918535478246;5729.914051289234;5755.510781583613;5756.5682573807135;5804.419558044162;1411.8235220597426;1443.8088576924079;1446.681730019394;1448.5002674077427;1452.6295794572527;932.1005229953128;960.9663661771805;970.5292932927524;986.7878406142714;990.6087095597198;5025.3718285214345;5034.093863104603;5072.594192464594;5073.898522029539;5080.517350851663;5923.733431995571;5964.403559644088;5988.2454071126895;5998.49012833914;6008.669523176267;4868.561829435368;5017.448080711119;5038.22897406425;5049.444561098277;5108.872278193075;3171.127939816523;3175.364927014606;3194.1375828526166;3203.6796320367775;3205.5351973963643;5486.396496385394;5586.888262234733;5592.580556458201;5609.5792815539;5609.691466969274;6018.548608854353;6140.697238535549;6186.226721659793;6187.597806142587;6195.380461953769;5596.272484576979;5625.38120806711;5625.839705522447;5637.8590535236945;5643.125315576092;6016.608920420159;6025.668588227514;6031.24609423822;6040.2147720797775;6054.7275372607455;5712.37163911961;5917.704114794329;5936.970315148396;5945.583809133319;5965;5584.776608935759;5590.217369568345;5601.439856014529;5604.103343465026;5632.183333416713;4019.376996565537;4060.3503439449546;4060.9390859136547;4091;4091.3453847384276;6045.818625441244;6061.242344706911;6063.272407310975;6072.90890636632;6074.32729598975;5833.941660583339;5844.795432159854;5850.7074646266665;5857.47282744555;5866;5703.044253266587;5816.592838501264;5822.835432913519;5829.5336373090895;5841.065429531254;5737.426257374229;5744.597878148489;5751.482366587027;5755.395683453177;5782.306123265067;5770.019096753478;5807.535397168301;5868.23712917318;5870.178175055581;5877.324107727495;5682.5453963681975;5713.7428815704225;5722.141678748055;5729.169270455677;5741.655500669973 12:22:45 INFO - PID 31115 | |5;yui.html;747.2863415438251;764.2739397572307;774.0363247756544;782.8316911863948;789.9644515996781;11646.883531164685;12328.075394345415;12711.173773704702;13172.604821855348;13197;14197.574072777834;14736.778948315783;15355.923220383911;15395.923020384882;15430.151341676203;838.9832203355944;853.8847255620474;856.0839901305606;856.1395797223781;857.9699710510133;908.6138391183754;910.7586489580267;912.6896855069275;913.6573784830689;917.5320586500899;946.1484663802564;953.3898305084751;954.7326748510428;955.4028732042474;956.3974695941582;941.1200527506769;952.5332587032339;952.9761755956088;958.5830163878735;959.6545243712258;694.586720901063;698.0506511144839;700.6251655364407;701.0220742064841;704.3801454719865;14112.788308175386;14509.419623215164;14606.926965365212;14757;14798.778018329735;15372.769408458882;15771.526854194393;15774.132422716746;16153.91923040389;16350;12169.574064907774;12396.628101156979;12446.25322480654;12477.251364918135;12599.370031498389;2914.2568644995604;2926.561015847619;2938.8824447022093;2947.425252075846;2954.4534261161753;69750.30249697539;70519;71543.64228178878;71554;72559.63720181365;12766.999999999814;12817.871821281668;12829.358532073358;12850.357482125857;12921.224726516439;22203.22288719887;22888.65667014996;22927.656085158735;22970.770292296864;23070.65394019091;6016.578839481282;6065.3934606539;6161.630302181883;6204.7828326008375;6227.06594010902;2975.821450712964;3039.589655396493;3047.3905218956297;3067.049214743392;3073.1702440340982;3494.405950988338;3550.0769799852224;3604.7837129772297;3608.747387682837;3621.402468592705;725.1624373848214;727;734.3207533031924;734.9816254593678;736.7163641997762;476.7568540044602;497.4528019178874;504.47282589693856;504.98485045448695;506.53398873036895;8700.08649091849;9109.817803644022;9857.901420985841;9986.500674966223;10558.788824223473;530.5914445876731;544.5453046706045;546.4508169289838;557.2811073714862;559.97480113395;3601.2077342984503;3607.981960090235;3612.7471077024356;3665.890023299305;3733.607971163043;59821;60879.69560152171;62399.6880015597;63652.36347636557;63811.36188638147;50514;50886.23670644943;52383.73808130935;53105.2034219487;53464.73267633637;45930.54069459329;46360.7681961588;46478;47138;47685;10367.637132700622;10551.155907527533;10727.463626818784;11049.779004419706;11194.44027798623;25398.873005635593;25602.87198563995;25963.05277104187;26531.734682652925;27232;41645.37531937084;42359;42936.63292088489;43552;43649.56350436582;13766.793498097337;13953.441862325393;14108.506202282872;14302.355229148365;14319;14613;14735.189564573622;14879.181645009628;15138;15221.6194595136;14310.856891430953;14383.280835958369;14657.853421466076;14814.925925370304;14846.480373186887;12924.806127908278;13031.218126912416;13066.085374024107;13183.14309569875;13345.66635834112;13642.86357136416;13871.375788089359;14059.22674252926;14133.081349712236;14306.713865722835;10147.391156530632;10191.898081019392;10449.268551201647;10602.522886469973;10609.575616975235;10930.72673183145;11093.50079246452;11585.88414115848;11621.535138594361;11758.70603234926 12:22:45 INFO - PID 31115 | __end_tp_report 12:22:45 INFO - PID 31115 | __start_cc_report 12:22:45 INFO - PID 31115 | _x_x_mozilla_cycle_collect,341 12:22:45 INFO - PID 31115 | __end_cc_report 12:22:45 INFO - PID 31115 | __startTimestamp1494444165121__endTimestamp 12:22:45 INFO - PID 31115 | 12:22:45 INFO - PID 31115 | ------- Summary: start ------- 12:22:45 INFO - PID 31115 | Number of tests: 6 12:22:45 INFO - PID 31115 | 12:22:45 INFO - PID 31115 | [#0] dojo.html Cycles:165 Average:5208.26 Median:5360.38 stddev:610.39 (11.4%) stddev-sans-first:579.95 12:22:45 INFO - PID 31115 | Values: 2710.0 2722.8 2723.7 2740.9 2750.7 5179.7 5279.3 5288.8 5295.9 5303.6 5215.0 5260.6 5263.4 5360.4 5400.6 4413.8 4667.2 4707.9 4751.7 4798.7 4781.0 4805.6 4852.0 4857.5 4870.1 4655.2 4697.8 4723.1 4736.1 4763.3 4594.4 4631.8 4669.4 4716.7 4733.2 4581.5 4593.0 4607.1 4639.1 4662.7 5176.2 5177.2 5204.1 5209.9 5216.8 5554.4 5567.6 5624.8 5724.3 5762.4 5714.1 5762.5 5770.4 5771.9 5808.1 5295.8 5297.4 5316.0 5319.3 5321.3 5772.7 5845.4 5861.7 5869.2 5879.0 5452.6 5480.2 5530.2 5535.3 5550.6 5676.4 5682.7 5691.6 5699.7 5706.3 5631.5 5641.8 5653.9 5663.3 5667.7 5644.0 5673.6 5681.7 5682.8 5690.7 4787.9 4790.5 4796.2 4804.1 4806.4 3974.9 4149.4 4154.9 4164.6 4172.8 4922.2 4925.2 4928.1 4931.1 4961.9 5781.0 5795.9 5803.0 5806.3 5855.9 4809.5 4880.8 4881.4 4901.0 4909.7 5038.8 5125.3 5149.1 5151.8 5152.8 5303.0 5319.5 5326.3 5328.1 5336.3 5703.6 5733.0 5747.8 5796.5 5822.4 5284.6 5345.2 5349.4 5352.9 5380.5 5640.4 5648.8 5670.6 5681.9 5730.4 5578.0 5644.7 5667.1 5679.8 5768.8 5466.0 5469.3 5470.5 5478.1 5478.9 5396.3 5440.4 5461.6 5470.2 5473.5 5379.4 5393.2 5399.3 5399.5 5399.8 5460.2 5476.8 5574.8 5654.7 5676.2 5458.9 5463.6 5464.7 5466.3 5473.3 12:22:45 INFO - PID 31115 | 12:22:45 INFO - PID 31115 | [#1] ext.html Cycles:180 Average:28549.52 Median:29243.56 stddev:38329.94 (131.1%) stddev-sans-first:38380.43 12:22:45 INFO - PID 31115 | Values: 703.2 1037.4 1049.9 1154.2 1165.2 29081.7 30043.5 30060.2 30061.0 30082.2 28449.1 28766.0 28845.4 28846.0 28960.0 6285.5 6317.2 6902.3 6925.1 6927.0 6654.8 6709.4 6722.0 6726.0 6735.3 6632.2 6705.9 6750.0 6752.5 6760.7 6695.8 6702.5 6704.6 6736.3 6756.4 6825.0 6825.9 6832.8 6851.0 6866.0 30122.0 30168.7 30195.2 30277.8 30323.5 3066.7 3099.3 3106.2 3118.9 3123.2 23418.6 23546.5 23569.8 23595.6 23636.8 3166.4 3182.1 3193.3 3212.5 3212.8 139124.3 139893.0 139946.3 140055.3 140211.3 36001.5 37934.5 37959.4 38056.2 38061.4 39395.6 39472.8 39592.6 39722.2 39841.4 11433.5 11459.1 11550.9 11600.6 11619.9 9143.5 9148.5 9192.0 9244.1 9288.0 11991.6 12064.0 12127.9 12137.3 12266.1 5114.4 5163.0 5178.7 5198.5 5213.2 870.6 897.5 905.3 906.9 935.3 19899.6 20725.6 20847.7 21052.4 21140.0 956.5 962.6 970.7 982.0 998.9 10239.2 10841.2 11022.5 11172.1 11188.4 164409.0 166346.0 166805.2 167008.0 167491.0 38007.2 38423.4 38492.0 38537.8 38540.0 1182.9 1202.5 1214.0 1214.4 1233.1 19092.2 19437.0 20038.3 20309.5 20470.8 26475.7 26533.5 26608.3 26616.2 26681.6 137166.0 138550.0 139259.0 139278.3 139393.0 27183.9 27588.7 27937.4 28442.4 29133.4 34224.0 34778.7 35004.0 35174.3 35181.8 26326.9 26646.2 26776.5 26885.9 27691.0 26096.5 26676.5 27094.6 27446.9 27622.9 28478.4 29353.7 29645.7 29658.4 29878.0 25610.4 26121.9 26711.9 27089.9 27161.0 20231.4 22051.6 22359.2 22382.1 22391.3 12:22:45 INFO - PID 31115 | 12:22:45 INFO - PID 31115 | [#2] jquery.html Cycles:180 Average:23923.30 Median:443.96 stddev:57593.85 (12972.6%) stddev-sans-first:57728.35 12:22:45 INFO - PID 31115 | Values: 409.0 415.1 426.1 443.7 444.2 15873.4 16467.4 17120.9 17166.2 17873.7 16668.2 17202.2 17333.7 18023.4 18295.3 5439.6 5481.0 5482.6 5554.2 5586.8 5420.6 5488.8 5494.5 5500.2 5519.6 5267.2 5437.5 5472.2 5523.1 5534.4 5400.1 5436.9 5467.8 5484.0 5506.5 4764.2 4891.8 4914.2 4942.8 4946.4 22103.2 22140.2 22345.7 23059.4 23115.8 1600.2 1638.1 1658.0 1666.8 1680.1 14563.8 14832.6 15108.6 15149.9 15327.2 2093.5 2119.4 2163.7 2179.6 2193.2 81855.6 86239.0 88640.0 95593.5 96129.5 10603.9 11044.3 11257.4 11270.3 11887.2 15478.8 15551.6 15555.2 15567.6 15615.9 7162.1 7255.8 7325.7 7365.4 7431.1 6496.1 6708.5 6761.5 6883.4 6949.2 7058.8 7090.6 7099.5 7178.9 7236.8 2042.4 2066.6 2091.8 2092.7 2185.7 811.4 856.1 861.6 864.8 875.1 17235.5 17482.4 17738.6 17985.5 18026.8 850.5 856.6 859.4 863.5 868.1 9540.1 9632.0 9898.9 9918.9 10026.6 338576.0 341771.0 344786.0 346045.0 354663.0 68039.7 71036.0 71552.3 72716.0 73535.0 997.4 1024.5 1050.5 1056.4 1056.4 14696.0 14798.8 15029.4 15032.4 15485.0 37429.0 37496.0 37792.4 37801.6 38682.2 46079.8 46127.8 46450.8 46605.4 47972.5 8022.6 8166.2 8233.9 8236.6 8566.3 11980.4 12894.0 13288.7 13546.1 13602.5 11005.2 11160.8 11395.0 11574.7 11801.9 8710.4 8897.2 9517.9 9837.3 9859.3 11346.7 11400.5 11424.1 11730.2 11891.7 8290.4 8385.0 8428.2 8558.8 8646.9 9692.3 9829.6 9918.7 10169.6 11117.6 12:22:45 INFO - PID 31115 | 12:22:45 INFO - PID 31115 | [#3] mootools.html Cycles:180 Average:6304.06 Median:3726.69 stddev:4168.79 (111.9%) stddev-sans-first:4162.97 12:22:45 INFO - PID 31115 | Values: 1219.2 1276.5 1279.9 1281.3 1283.7 9766.6 10204.5 10213.7 10398.1 10628.5 10414.5 10548.4 10578.5 10591.2 10628.3 2203.6 2241.7 2250.5 2251.7 2260.0 1976.1 2016.5 2018.7 2023.5 2024.0 2204.6 2238.0 2244.1 2262.8 2281.2 2140.3 2190.8 2196.7 2201.3 2208.4 1874.7 1999.2 2006.1 2128.1 2158.6 10311.8 10422.6 10456.5 10458.3 10489.4 5304.5 5453.5 5478.2 5492.4 5501.6 3087.7 3302.5 3345.4 3366.2 3429.7 1060.0 1082.4 1099.7 1099.9 1107.5 15265.7 15281.2 15400.0 15447.7 15456.5 4697.9 4840.2 5042.3 5088.2 5099.5 11010.3 11027.9 11046.3 11069.2 11074.6 5354.2 5358.7 5374.2 5391.1 5412.3 4895.6 4919.9 4920.0 5115.7 5284.9 3789.2 3882.3 3915.1 3937.4 3966.4 1124.7 1132.6 1139.4 1146.5 1149.1 586.1 594.9 595.2 599.2 600.1 5053.3 5114.8 5119.0 5144.7 5241.4 541.2 549.2 802.5 823.3 838.8 3616.3 3700.1 3753.3 3815.5 3846.4 13588.5 13819.7 14031.8 14101.6 14113.9 13508.4 13509.0 13692.8 13736.6 13763.2 7373.6 7456.9 7551.1 7557.2 7596.5 5885.3 5906.1 5999.2 6038.0 6112.9 12077.8 12113.2 12119.0 12235.2 12247.2 12375.1 12409.4 12427.4 12448.3 12592.9 7582.6 7694.7 7708.0 7757.2 7761.2 9731.4 9782.4 9806.3 9813.3 9836.7 8000.0 8061.3 8142.6 8143.6 8292.3 7944.6 7949.0 7973.5 8007.7 8136.0 7122.8 7144.9 7153.7 7238.6 7276.2 5059.3 5061.4 5078.3 5130.0 5213.7 5182.8 5255.1 5323.3 5341.5 5380.7 12:22:45 INFO - PID 31115 | 12:22:45 INFO - PID 31115 | [#4] prototype.html Cycles:180 Average:4776.62 Median:5520.56 stddev:1426.08 (25.8%) stddev-sans-first:1391.16 12:22:45 INFO - PID 31115 | Values: 368.1 396.8 397.2 405.1 406.3 5554.7 5604.7 5605.1 5610.4 5622.6 5457.8 5474.3 5477.4 5482.2 5485.6 3906.4 4053.6 4111.2 4111.6 4116.9 4090.1 4119.6 4124.4 4139.2 4142.4 4091.1 4092.4 4105.7 4114.5 4120.4 4056.5 4081.3 4083.1 4119.2 4123.6 3560.4 3585.7 3587.0 3587.1 3592.5 5335.7 5346.7 5357.4 5362.3 5368.8 4779.6 4814.9 4828.6 4834.6 4849.7 5722.7 5745.2 5757.2 5757.4 5775.2 4018.8 4032.4 4038.6 4039.1 4049.3 5971.4 6074.3 6077.9 6167.1 6167.6 4054.0 4114.3 4116.9 4130.7 4144.8 4173.2 4197.1 4197.3 4198.0 4201.8 4722.3 4792.2 4802.7 4824.5 4838.0 5691.9 5729.9 5755.5 5756.6 5804.4 1411.8 1443.8 1446.7 1448.5 1452.6 932.1 961.0 970.5 986.8 990.6 5025.4 5034.1 5072.6 5073.9 5080.5 5923.7 5964.4 5988.2 5998.5 6008.7 4868.6 5017.4 5038.2 5049.4 5108.9 3171.1 3175.4 3194.1 3203.7 3205.5 5486.4 5586.9 5592.6 5609.6 5609.7 6018.5 6140.7 6186.2 6187.6 6195.4 5596.3 5625.4 5625.8 5637.9 5643.1 6016.6 6025.7 6031.2 6040.2 6054.7 5712.4 5917.7 5937.0 5945.6 5965.0 5584.8 5590.2 5601.4 5604.1 5632.2 4019.4 4060.4 4060.9 4091.0 4091.3 6045.8 6061.2 6063.3 6072.9 6074.3 5833.9 5844.8 5850.7 5857.5 5866.0 5703.0 5816.6 5822.8 5829.5 5841.1 5737.4 5744.6 5751.5 5755.4 5782.3 5770.0 5807.5 5868.2 5870.2 5877.3 5682.5 5713.7 5722.1 5729.2 5741.7 12:22:45 INFO - PID 31115 | 12:22:45 INFO - PID 31115 | [#5] yui.html Cycles:180 Average:15177.75 Median:3283.79 stddev:17748.20 (540.5%) stddev-sans-first:17764.91 12:22:45 INFO - PID 31115 | Values: 747.3 764.3 774.0 782.8 790.0 11646.9 12328.1 12711.2 13172.6 13197.0 14197.6 14736.8 15355.9 15395.9 15430.2 839.0 853.9 856.1 856.1 858.0 908.6 910.8 912.7 913.7 917.5 946.1 953.4 954.7 955.4 956.4 941.1 952.5 953.0 958.6 959.7 694.6 698.1 700.6 701.0 704.4 14112.8 14509.4 14606.9 14757.0 14798.8 15372.8 15771.5 15774.1 16153.9 16350.0 12169.6 12396.6 12446.3 12477.3 12599.4 2914.3 2926.6 2938.9 2947.4 2954.5 69750.3 70519.0 71543.6 71554.0 72559.6 12767.0 12817.9 12829.4 12850.4 12921.2 22203.2 22888.7 22927.7 22970.8 23070.7 6016.6 6065.4 6161.6 6204.8 6227.1 2975.8 3039.6 3047.4 3067.0 3073.2 3494.4 3550.1 3604.8 3608.7 3621.4 725.2 727.0 734.3 735.0 736.7 476.8 497.5 504.5 505.0 506.5 8700.1 9109.8 9857.9 9986.5 10558.8 530.6 544.5 546.5 557.3 560.0 3601.2 3608.0 3612.7 3665.9 3733.6 59821.0 60879.7 62399.7 63652.4 63811.4 50514.0 50886.2 52383.7 53105.2 53464.7 45930.5 46360.8 46478.0 47138.0 47685.0 10367.6 10551.2 10727.5 11049.8 11194.4 25398.9 25602.9 25963.1 26531.7 27232.0 41645.4 42359.0 42936.6 43552.0 43649.6 13766.8 13953.4 14108.5 14302.4 14319.0 14613.0 14735.2 14879.2 15138.0 15221.6 14310.9 14383.3 14657.9 14814.9 14846.5 12924.8 13031.2 13066.1 13183.1 13345.7 13642.9 13871.4 14059.2 14133.1 14306.7 10147.4 10191.9 10449.3 10602.5 10609.6 10930.7 11093.5 11585.9 11621.5 11758.7 12:22:45 INFO - PID 31115 | -------- Summary: end -------- 12:22:45 INFO - PID 31115 | 12:22:45 INFO - TEST-INFO | 31115: exit 0 12:22:45 INFO - TEST-OK | dromaeo_css | took 1120386ms 12:22:45 INFO - TEST-START | kraken 12:22:45 INFO - operating with platform_type : linux_ 12:22:45 INFO - Initialising browser for kraken test... 12:22:45 INFO - TEST-INFO | started process 31532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSfeQGN/profile http://localhost:37490/getInfo.html) 12:22:49 INFO - PID 31532 | __metrics Screen width/height:1600/1200 12:22:49 INFO - PID 31532 | colorDepth:24 12:22:49 INFO - PID 31532 | Browser inner width/height: 1024/695 12:22:49 INFO - PID 31532 | __metrics 12:22:51 INFO - TEST-INFO | 31532: exit 0 12:22:51 INFO - Browser initialized. 12:22:51 INFO - Running cycle 1/1 for kraken test... 12:22:51 INFO - TEST-INFO | started process 31706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSfeQGN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:23:03 INFO - PID 31706 | RSS: Main: 155136000 12:23:03 INFO - PID 31706 | 12:23:06 INFO - PID 31706 | Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37490/tests/kraken/driver.html?testName=audio-beat-detection) 12:23:07 INFO - PID 31706 | RSS: Main: 161529856 12:23:07 INFO - PID 31706 | 12:23:09 INFO - PID 31706 | Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37490/tests/kraken/driver.html?testName=audio-dft) 12:23:10 INFO - PID 31706 | RSS: Main: 160460800 12:23:10 INFO - PID 31706 | 12:23:13 INFO - PID 31706 | Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37490/tests/kraken/driver.html?testName=audio-fft) 12:23:14 INFO - PID 31706 | RSS: Main: 156786688 12:23:14 INFO - PID 31706 | 12:23:16 INFO - PID 31706 | Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37490/tests/kraken/driver.html?testName=audio-oscillator) 12:23:16 INFO - PID 31706 | RSS: Main: 157126656 12:23:16 INFO - PID 31706 | 12:23:18 INFO - PID 31706 | Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37490/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:23:19 INFO - PID 31706 | RSS: Main: 157298688 12:23:19 INFO - PID 31706 | 12:23:22 INFO - PID 31706 | Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37490/tests/kraken/driver.html?testName=imaging-darkroom) 12:23:23 INFO - PID 31706 | RSS: Main: 163172352 12:23:23 INFO - PID 31706 | 12:23:26 INFO - PID 31706 | Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37490/tests/kraken/driver.html?testName=imaging-desaturate) 12:23:27 INFO - PID 31706 | RSS: Main: 161275904 12:23:27 INFO - PID 31706 | 12:23:30 INFO - PID 31706 | Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37490/tests/kraken/driver.html?testName=json-parse-financial) 12:23:31 INFO - PID 31706 | RSS: Main: 162488320 12:23:31 INFO - PID 31706 | 12:23:32 INFO - PID 31706 | Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37490/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:23:33 INFO - PID 31706 | RSS: Main: 162676736 12:23:33 INFO - PID 31706 | 12:23:35 INFO - PID 31706 | Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37490/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:23:35 INFO - PID 31706 | RSS: Main: 162545664 12:23:35 INFO - PID 31706 | 12:23:37 INFO - PID 31706 | Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37490/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:23:38 INFO - PID 31706 | RSS: Main: 162557952 12:23:38 INFO - PID 31706 | 12:23:41 INFO - PID 31706 | Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37490/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:23:42 INFO - PID 31706 | RSS: Main: 162893824 12:23:42 INFO - PID 31706 | 12:23:45 INFO - PID 31706 | Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37490/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:23:45 INFO - PID 31706 | RSS: Main: 163053568 12:23:45 INFO - PID 31706 | 12:23:47 INFO - PID 31706 | Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37490/tests/kraken/driver.html?testName=ai-astar) 12:23:47 INFO - PID 31706 | RSS: Main: 164339712 12:23:47 INFO - PID 31706 | 12:23:47 INFO - PID 31706 | __start_tp_report 12:23:47 INFO - PID 31706 | _x_x_mozilla_page_load 12:23:47 INFO - PID 31706 | _x_x_mozilla_page_load_details 12:23:47 INFO - PID 31706 | |i|pagename|runs| 12:23:47 INFO - PID 31706 | |0;ai-astar;104;115;113;112;111;112;112;112;112;112 12:23:47 INFO - PID 31706 | |1;audio-beat-detection;148;130;125;169;127;125;124;130;150;125 12:23:47 INFO - PID 31706 | |2;audio-dft;169;165;164;163;169;165;168;164;164;165 12:23:47 INFO - PID 31706 | |3;audio-fft;75;79;78;109;79;74;76;75;108;75 12:23:47 INFO - PID 31706 | |4;audio-oscillator;83;82;101;84;83;85;96;83;83;107 12:23:47 INFO - PID 31706 | |5;imaging-gaussian-blur;114;115;113;114;114;115;115;117;114;114 12:23:47 INFO - PID 31706 | |6;imaging-darkroom;150;150;150;151;150;150;151;150;152;149 12:23:47 INFO - PID 31706 | |7;imaging-desaturate;95;96;95;94;95;95;95;94;94;98 12:23:47 INFO - PID 31706 | |8;json-parse-financial;54;53;56;53;55;56;55;56;57;56 12:23:47 INFO - PID 31706 | |9;json-stringify-tinderbox;57;57;57;56;58;57;57;57;57;56 12:23:47 INFO - PID 31706 | |10;stanford-crypto-aes;86;83;82;82;82;85;83;83;82;92 12:23:47 INFO - PID 31706 | |11;stanford-crypto-ccm;134;134;144;131;133;133;130;140;176;131 12:23:47 INFO - PID 31706 | |12;stanford-crypto-pbkdf2;187;193;192;190;198;206;190;188;182;192 12:23:47 INFO - PID 31706 | |13;stanford-crypto-sha256-iterative;76;75;74;75;78;73;75;72;73;75 12:23:47 INFO - PID 31706 | __end_tp_report 12:23:47 INFO - PID 31706 | __start_cc_report 12:23:47 INFO - PID 31706 | _x_x_mozilla_cycle_collect,847 12:23:47 INFO - PID 31706 | __end_cc_report 12:23:47 INFO - PID 31706 | __startTimestamp1494444227933__endTimestamp 12:23:47 INFO - PID 31706 | 12:23:47 INFO - PID 31706 | ------- Summary: start ------- 12:23:47 INFO - PID 31706 | Number of tests: 14 12:23:47 INFO - PID 31706 | 12:23:47 INFO - PID 31706 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:2.84 (2.5%) stddev-sans-first:1.12 12:23:47 INFO - PID 31706 | Values: 104.0 115.0 113.0 112.0 111.0 112.0 112.0 112.0 112.0 112.0 12:23:47 INFO - PID 31706 | 12:23:47 INFO - PID 31706 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:130.00 stddev:15.22 (11.7%) stddev-sans-first:15.43 12:23:47 INFO - PID 31706 | Values: 148.0 130.0 125.0 169.0 127.0 125.0 124.0 130.0 150.0 125.0 12:23:47 INFO - PID 31706 | 12:23:47 INFO - PID 31706 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.00 stddev:2.22 (1.3%) stddev-sans-first:1.99 12:23:47 INFO - PID 31706 | Values: 169.0 165.0 164.0 163.0 169.0 165.0 168.0 164.0 164.0 165.0 12:23:47 INFO - PID 31706 | 12:23:47 INFO - PID 31706 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.50 stddev:13.66 (18.1%) stddev-sans-first:14.20 12:23:47 INFO - PID 31706 | Values: 75.0 79.0 78.0 109.0 79.0 74.0 76.0 75.0 108.0 75.0 12:23:47 INFO - PID 31706 | 12:23:47 INFO - PID 31706 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:83.00 stddev:9.13 (11.0%) stddev-sans-first:9.45 12:23:47 INFO - PID 31706 | Values: 83.0 82.0 101.0 84.0 83.0 85.0 96.0 83.0 83.0 107.0 12:23:47 INFO - PID 31706 | 12:23:47 INFO - PID 31706 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.50 stddev:1.08 (0.9%) stddev-sans-first:1.13 12:23:47 INFO - PID 31706 | Values: 114.0 115.0 113.0 114.0 114.0 115.0 115.0 117.0 114.0 114.0 12:23:47 INFO - PID 31706 | 12:23:47 INFO - PID 31706 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 12:23:47 INFO - PID 31706 | Values: 150.0 150.0 150.0 151.0 150.0 150.0 151.0 150.0 152.0 149.0 12:23:47 INFO - PID 31706 | 12:23:47 INFO - PID 31706 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:1.20 (1.3%) stddev-sans-first:1.27 12:23:47 INFO - PID 31706 | Values: 95.0 96.0 95.0 94.0 95.0 95.0 95.0 94.0 94.0 98.0 12:23:47 INFO - PID 31706 | 12:23:47 INFO - PID 31706 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:56.00 stddev:1.37 (2.4%) stddev-sans-first:1.39 12:23:47 INFO - PID 31706 | Values: 54.0 53.0 56.0 53.0 55.0 56.0 55.0 56.0 57.0 56.0 12:23:47 INFO - PID 31706 | 12:23:47 INFO - PID 31706 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 12:23:47 INFO - PID 31706 | Values: 57.0 57.0 57.0 56.0 58.0 57.0 57.0 57.0 57.0 56.0 12:23:47 INFO - PID 31706 | 12:23:47 INFO - PID 31706 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.00 stddev:3.13 (3.8%) stddev-sans-first:3.23 12:23:47 INFO - PID 31706 | Values: 86.0 83.0 82.0 82.0 82.0 85.0 83.0 83.0 82.0 92.0 12:23:47 INFO - PID 31706 | 12:23:47 INFO - PID 31706 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:134.00 stddev:13.84 (10.3%) stddev-sans-first:14.58 12:23:47 INFO - PID 31706 | Values: 134.0 134.0 144.0 131.0 133.0 133.0 130.0 140.0 176.0 131.0 12:23:47 INFO - PID 31706 | 12:23:47 INFO - PID 31706 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.80 Median:192.00 stddev:6.51 (3.4%) stddev-sans-first:6.67 12:23:47 INFO - PID 31706 | Values: 187.0 193.0 192.0 190.0 198.0 206.0 190.0 188.0 182.0 192.0 12:23:47 INFO - PID 31706 | 12:23:47 INFO - PID 31706 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:75.00 stddev:1.71 (2.3%) stddev-sans-first:1.74 12:23:47 INFO - PID 31706 | Values: 76.0 75.0 74.0 75.0 78.0 73.0 75.0 72.0 73.0 75.0 12:23:47 INFO - PID 31706 | -------- Summary: end -------- 12:23:47 INFO - PID 31706 | 12:23:49 INFO - TEST-INFO | 31706: exit 0 12:23:49 INFO - TEST-OK | kraken | took 63165ms 12:23:49 INFO - SUITE-END | took 1183s 12:23:49 INFO - Completed test suite (00:19:44) 12:23:49 INFO - javascript benchmark 12:23:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6646.425144410424, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2710.0, 2722.7957903157244, 2723.6731592208926, 2740.8629568521574, 2750.7111753265917, 5179.689218646874, 5279.3400824896935, 5288.8413347599535, 5295.894082118355, 5303.57571394288, 5214.973925130378, 5260.605454590902, 5263.3683957925105, 5360.383555891074, 5400.648957817739, 4413.845515406962, 4667.172160587438, 4707.917179048821, 4751.667383283171, 4798.712077275374, 4780.976095119519, 4805.567498925096, 4852.0, 4857.465678775332, 4870.147724148278, 4655.185342565038, 4697.812087516495, 4723.149833030053, 4736.123817093849, 4763.261694437333, 4594.356790049395, 4631.8378856739855, 4669.41632295963, 4716.716996980158, 4733.171694953369, 4581.541845815425, 4593.035462552868, 4607.14767767964, 4639.072185562901, 4662.743549104798, 5176.2235664650225, 5177.171652535614, 5204.063268611649, 5209.895802083975, 5216.7913283468615, 5554.389017208104, 5567.638103523258, 5624.775008999635, 5724.341700704389, 5762.366139724627, 5714.114312281561, 5762.510186634141, 5770.394108618619, 5771.913421298684, 5808.070708686632, 5295.788168473295, 5297.364316282071, 5315.989961907225, 5319.255304257407, 5321.281626980385, 5772.653640781483, 5845.386234445407, 5861.677607731531, 5869.178315035899, 5878.970605147032, 5452.618316717871, 5480.232767412565, 5530.170474428868, 5535.308086489189, 5550.555955523549, 5676.403977582295, 5682.687452190169, 5691.573132015115, 5699.715014249271, 5706.28671416073, 5631.465010823965, 5641.830745077655, 5653.858653533694, 5663.348714897757, 5667.716614169358, 5644.0, 5673.602847800615, 5681.744321505542, 5682.801101961411, 5690.715464226772, 4787.928181077286, 4790.473047964721, 4796.232602783608, 4804.06320767447, 4806.375171227788, 3974.8807535773394, 4149.439825623563, 4154.937675934863, 4164.646005089541, 4172.7913604319665, 4922.187839006524, 4925.1873440881855, 4928.137575924199, 4931.0630980113665, 4961.900761984813, 5781.046127388934, 5795.94204057954, 5803.0, 5806.274215723035, 5855.853603659943, 4809.5430934061205, 4880.82917097907, 4881.414230292387, 4900.950990490121, 4909.656324057353, 5038.823641172541, 5125.256837758504, 5149.073166830007, 5151.8196863109615, 5152.76812543429, 5303.045451818555, 5319.547838433777, 5326.307580014573, 5328.067588171977, 5336.306280183707, 5703.600747947604, 5733.0, 5747.827565173052, 5796.478316951495, 5822.417758224144, 5284.577233821208, 5345.198220266836, 5349.411564727799, 5352.866178345573, 5380.542653874464, 5640.407757185437, 5648.802291919763, 5670.574706896917, 5681.9431805681415, 5730.426957304237, 5577.972110139423, 5644.717764111861, 5667.149927510906, 5679.77280908759, 5768.769249229984, 5466.043442397644, 5469.288992430958, 5470.480304371078, 5478.096114141282, 5478.890422191614, 5396.298481197577, 5440.4015558287765, 5461.563074953915, 5470.179473078911, 5473.534749546333, 5379.381371142369, 5393.244945707525, 5399.2980912481125, 5399.487048730364, 5399.83800485986, 5460.208269800777, 5476.835694929158, 5574.804881829116, 5654.745536450787, 5676.233708449472, 5458.890822183614, 5463.562914966873, 5464.726763661881, 5466.316710411199, 5473.28847249855], "value": 5163.758843807225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.1527009953007, 1037.3879411147423, 1049.8687664041995, 1154.2382027861613, 1165.2076587920221, 29081.70918290819, 30043.549346759817, 30060.248493787665, 30061.0, 30082.247943801416, 28449.146525604265, 28766.0, 28845.423091538156, 28846.0, 28960.0, 6285.4971602271935, 6317.210348706411, 6902.344277293674, 6925.134358205224, 6926.965365173167, 6654.800355989304, 6709.429698475636, 6721.966390168042, 6726.0, 6735.259121496631, 6632.1709786276715, 6705.865882682343, 6750.0, 6752.493562982771, 6760.729570817161, 6695.765648202289, 6702.530822842403, 6704.564203326768, 6736.292689267605, 6756.391924726749, 6824.965875170642, 6825.863482730318, 6832.795016149524, 6851.0, 6866.0, 30122.0, 30168.698313017027, 30195.245118871986, 30277.848610756806, 30323.545146822817, 3066.693330666938, 3099.271671157276, 3106.1923899785993, 3118.8908388206532, 3123.172359324758, 23418.648720269208, 23546.529069418517, 23569.76430235693, 23595.646065309033, 23636.76363236363, 3166.3825554016976, 3182.0771976126894, 3193.281511659858, 3212.518122281653, 3212.775105742599, 139124.30437847847, 139893.0, 139946.30026849904, 140055.29972350074, 140211.29894350565, 36001.45997810035, 37934.46474543206, 37959.4306085409, 38056.238875222894, 38061.429078563844, 39395.606043939195, 39472.802635986634, 39592.60407395947, 39722.20555588872, 39841.40237896434, 11433.485493152828, 11459.083273338112, 11550.88449115515, 11600.593979210687, 11619.941900290445, 9143.54282285883, 9148.496832674135, 9192.0, 9244.121808428188, 9287.953560232156, 11991.580294689818, 12064.0, 12127.878721212675, 12137.271763694207, 12266.141370104186, 5114.43741188469, 5163.0, 5178.71517066565, 5198.544407565888, 5213.244079608436, 870.6473878079262, 897.4749771383683, 905.3164860530258, 906.9388815086234, 935.2938531408743, 19899.60200795976, 20725.58548829015, 20847.687284690743, 21052.36842894685, 21140.0, 956.4691596164057, 962.5620342744035, 970.6990832841842, 981.9558119884622, 998.9100980911753, 10239.18086553074, 10841.18691098155, 11022.50398732059, 11172.10623150146, 11188.440577971069, 164409.0, 166346.0, 166805.16597417177, 167008.0, 167491.0, 38007.239855202744, 38423.423648645294, 38492.0, 38537.80731096383, 38540.0, 1182.869884312725, 1202.5189924030283, 1214.0469731261094, 1214.4352875912743, 1233.0875152387168, 19092.23631054742, 19437.0, 20038.298659546846, 20309.49226269355, 20470.79529204689, 26475.735242648097, 26533.469330612894, 26608.33479162959, 26616.201513954613, 26681.599776002986, 137166.0, 138550.0, 139259.0, 139278.3036084813, 139393.0, 27183.86408068026, 27588.724112758617, 27937.44125117527, 28442.43115137727, 29133.417331653673, 34224.0, 34778.652213478555, 35004.0, 35174.29651407008, 35181.82409087938, 26326.86836565805, 26646.20061398161, 26776.46447071009, 26885.865570672802, 27691.0, 26096.478070438865, 26676.466470670865, 27094.593581095905, 27446.862765686044, 27622.861885690443, 28478.43043139167, 29353.706462935952, 29645.703542964293, 29658.40683186281, 29878.0, 25610.35974100588, 26121.869390653686, 26711.866440667673, 27089.86455067712, 27161.049363272192, 20231.393058208276, 22051.558968820853, 22359.21742738996, 22382.104715811187, 22391.328260152222], "value": 13955.17558395216, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.96932730045256, 415.0517867126572, 426.0860454325473, 443.7204561126492, 444.20709034373647, 15873.444429444971, 16467.423640172598, 17120.914395428023, 17166.22751976161, 17873.731894021566, 16668.16659167043, 17202.225899834506, 17333.653326933454, 18023.36918207863, 18295.268189272414, 5439.646422982513, 5480.972595137018, 5482.588805839578, 5554.1946417769395, 5586.776528938837, 5420.5934554908345, 5488.7530061147145, 5494.5054945054935, 5500.22996780451, 5519.586031047667, 5267.23625074364, 5437.477506298243, 5472.179173124044, 5523.061079616455, 5534.363548191969, 5400.054990376688, 5436.891262174754, 5467.753951072172, 5484.0, 5506.531944784698, 4764.190087685067, 4891.804327826882, 4914.213725803854, 4942.752862356868, 4946.3817022872145, 22103.226387076375, 22140.2250921217, 22345.664815027787, 23059.423514412105, 23115.76884231153, 1600.1519194826644, 1638.0990455249685, 1657.966840663192, 1666.7749853769708, 1680.0591668665586, 14563.781543276858, 14832.555023349316, 15108.622284442867, 15149.924250378788, 15327.157006364645, 2093.5080256139795, 2119.395972147946, 2163.707899433572, 2179.6403593407067, 2193.243331050785, 81855.5907220466, 86239.0, 88640.0, 95593.52203239009, 96129.51935240348, 10603.89396106029, 11044.33733975964, 11257.380844053656, 11270.267432616854, 11887.227330223508, 15478.767818482731, 15551.611209719847, 15555.22223888801, 15567.610809729847, 15615.939855637616, 7162.0920280842865, 7255.836183591382, 7325.733693892826, 7365.373943214887, 7431.142214446389, 6496.090547323379, 6708.463322934153, 6761.4590832733265, 6883.414909732629, 6949.200841903245, 7058.788236352918, 7090.6100164491445, 7099.538529995534, 7178.892316615255, 7236.819079523054, 2042.4179108953876, 2066.5970135823673, 2091.7699053104147, 2092.6547119725074, 2185.715856938588, 811.3752410643772, 856.1310270075753, 861.6251930410292, 864.8097418567905, 875.1336177184542, 17235.482935511955, 17482.388116415863, 17738.5565360867, 17985.514418102342, 18026.819731802778, 850.4897061763016, 856.6102423397339, 859.3769517100052, 863.4560227056913, 868.079835374505, 9540.093691099335, 9631.951840240754, 9898.851517227247, 9918.851217231748, 10026.64906728261, 338576.0, 341771.0, 344786.0, 346045.0, 354663.0, 68039.65980170068, 71036.0, 71552.2844771556, 72716.0, 73535.0, 997.4165113408592, 1024.4519182237468, 1050.5167622893402, 1056.4136904018344, 1056.4400867540216, 14696.0, 14798.77801832995, 15029.398824047354, 15032.398704052153, 15485.0, 37429.0, 37496.0, 37792.43311350277, 37801.62198377981, 38682.22635547329, 46079.76960115178, 46127.76936115298, 46450.76774616105, 46605.368812091416, 47972.520274798204, 8022.598870056357, 8166.183381661786, 8233.917660823316, 8236.588170591567, 8566.271866891135, 11980.400979951142, 12894.0, 13288.734225315633, 13546.119502232323, 13602.455901763818, 11005.229633925548, 11160.776784464102, 11395.0, 11574.6527604172, 11801.881981180079, 8710.433821801562, 8897.199252067345, 9517.904820951979, 9837.311388202757, 9859.30984831055, 11346.659600212008, 11400.48697808584, 11424.143189261005, 11730.178887477794, 11891.702707432383, 8290.377578591813, 8385.0, 8428.160933850717, 8558.828823423371, 8646.870296945677, 9692.321537492307, 9829.606815727291, 9918.702438926844, 10169.593216271267, 11117.610883619358], "value": 8732.538152736553, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1219.1892391559613, 1276.4702648400914, 1279.878411550903, 1281.2632736176702, 1283.7111649878777, 9766.609335626576, 10204.489775511232, 10213.693589192328, 10398.116160126398, 10628.46857657116, 10414.531346089425, 10548.419836908966, 10578.471076446185, 10591.205659575524, 10628.256022078458, 2203.592335417949, 2241.663750437431, 2250.516139030108, 2251.7410497792716, 2259.954800903981, 1976.10087410228, 2016.5462770876509, 2018.6669199582052, 2023.4738967868313, 2023.959520809583, 2204.64725643897, 2238.0, 2244.057495851738, 2262.8189744820456, 2281.178775640768, 2140.2509121807398, 2190.8356873234493, 2196.681481185235, 2201.2845825106824, 2208.3595757230382, 1874.681304178293, 1999.1503610965426, 2006.0671787618828, 2128.053016407699, 2158.6438237690763, 10311.84532232017, 10422.583096676124, 10456.529456174414, 10458.320209186379, 10489.423081730578, 5304.469553044703, 5453.481919217668, 5478.205660179252, 5492.423295553989, 5501.559875209973, 3087.72210501056, 3302.488114342281, 3345.4312766829453, 3366.208940898887, 3429.725621950238, 1059.973500662482, 1082.377632861108, 1099.7305660113323, 1099.8955099265556, 1107.545906178463, 15265.694686106326, 15281.235938203044, 15400.0, 15447.691046179127, 15456.536303910902, 4697.859064228079, 4840.15297322967, 5042.3444952156715, 5088.236764485283, 5099.515546023122, 11010.339379637247, 11027.944860275808, 11046.33721976668, 11069.169812264112, 11074.612388566362, 5354.170103633943, 5358.705271210043, 5374.167004114369, 5391.083515802323, 5412.296401467784, 4895.559399654048, 4919.852404427873, 4920.0, 5115.693058416507, 5284.9471505284455, 3789.2232092420986, 3882.340596691219, 3915.0799562102884, 3937.3897045957924, 3966.3852102924093, 1124.651358078998, 1132.6318946342471, 1139.3733446604335, 1146.4611632532697, 1149.143887803575, 586.1383765864173, 594.9018411962064, 595.1727099331932, 599.179124599293, 600.1328080923024, 5053.267276244924, 5114.795408183705, 5119.0273847968765, 5144.742762861842, 5241.36139516523, 541.182813950937, 549.2228496677156, 802.5024484819332, 823.3125340340763, 838.8112674648278, 3616.3129005488872, 3700.0564855961557, 3753.324401607737, 3815.503984482055, 3846.4230365445405, 13588.505264420906, 13819.723605528034, 14031.78952315716, 14101.647458813406, 14113.929430352782, 13508.392122354519, 13509.0, 13692.794608080887, 13736.587902362946, 13763.174209547458, 7373.5944523050675, 7456.850862982818, 7551.093868735677, 7557.206493318233, 7596.544207347577, 5885.264341957255, 5906.084556893688, 5999.220101386792, 6037.969810150921, 6112.908306375319, 12077.818832717692, 12113.15207935436, 12119.0, 12235.204711693712, 12247.203931744409, 12375.071869609636, 12409.44157512896, 12427.378631068592, 12448.25310481374, 12592.87407125917, 7582.62086895642, 7694.653740581575, 7708.03649543807, 7757.224277572198, 7761.223877612194, 9731.367461115287, 9782.364146330467, 9806.313558050868, 9813.264005199495, 9836.704898853046, 7999.9600001999615, 8061.2744852963515, 8142.592870356577, 8143.5928203590765, 8292.2951549119, 7944.563049032358, 7948.96663433773, 7973.481723687942, 8007.719729809429, 8135.959320203598, 7122.7507037253445, 7144.892826607501, 7153.678084486107, 7238.6380680964685, 7276.235995220637, 5059.342285502861, 5061.38787377887, 5078.289039534542, 5129.9743501282255, 5213.687178769286, 5182.766775495036, 5255.13290307095, 5323.30796996388, 5341.465853414627, 5380.730963451733], "value": 4674.10456792886, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.0779646984304, 396.76590811421266, 397.22937501247594, 405.0622808199019, 406.32752794125713, 5554.722263886804, 5604.691741954191, 5605.103183490643, 5610.410906854782, 5622.634528755628, 5457.754401051952, 5474.343078830536, 5477.424870388611, 5482.150266708657, 5485.61600687951, 3906.355451350531, 4053.5541090480024, 4111.198316328318, 4111.60939710727, 4116.8970775730695, 4090.1389867610314, 4119.5880411958715, 4124.443200167969, 4139.2135494256145, 4142.399352093945, 4091.0590564170257, 4092.4475195848627, 4105.668519711703, 4114.547399786021, 4120.361343991671, 4056.5132184137797, 4081.265372232997, 4083.1221287423346, 4119.237940980913, 4123.649489793371, 3560.4481305397703, 3585.695215906651, 3587.0494319005484, 3587.0852932502044, 3592.5329707138167, 5335.653182543161, 5346.732663366816, 5357.383900851413, 5362.276092727471, 5368.812091576776, 4779.569838714498, 4814.927776083362, 4828.5654291113615, 4834.58905992991, 4849.709017458928, 5722.685252311121, 5745.166950792153, 5757.193992841006, 5757.395473475309, 5775.16260142277, 4018.819153138116, 4032.374981877784, 4038.5759495253164, 4039.1315867088715, 4049.250888585621, 5971.402859714038, 6074.331823499411, 6077.878442431127, 6167.074938759177, 6167.629942203482, 4054.006768341775, 4114.341705327133, 4116.938245926313, 4130.710850240514, 4144.7513149210545, 4173.2055216256695, 4197.097624010852, 4197.3074442717225, 4197.958020419818, 4201.768902710381, 4722.291656251589, 4792.161371759928, 4802.718708613381, 4824.517548245148, 4837.975810120927, 5691.918535478246, 5729.914051289234, 5755.510781583613, 5756.5682573807135, 5804.419558044162, 1411.8235220597426, 1443.8088576924079, 1446.681730019394, 1448.5002674077427, 1452.6295794572527, 932.1005229953128, 960.9663661771805, 970.5292932927524, 986.7878406142714, 990.6087095597198, 5025.3718285214345, 5034.093863104603, 5072.594192464594, 5073.898522029539, 5080.517350851663, 5923.733431995571, 5964.403559644088, 5988.2454071126895, 5998.49012833914, 6008.669523176267, 4868.561829435368, 5017.448080711119, 5038.22897406425, 5049.444561098277, 5108.872278193075, 3171.127939816523, 3175.364927014606, 3194.1375828526166, 3203.6796320367775, 3205.5351973963643, 5486.396496385394, 5586.888262234733, 5592.580556458201, 5609.5792815539, 5609.691466969274, 6018.548608854353, 6140.697238535549, 6186.226721659793, 6187.597806142587, 6195.380461953769, 5596.272484576979, 5625.38120806711, 5625.839705522447, 5637.8590535236945, 5643.125315576092, 6016.608920420159, 6025.668588227514, 6031.24609423822, 6040.2147720797775, 6054.7275372607455, 5712.37163911961, 5917.704114794329, 5936.970315148396, 5945.583809133319, 5965.0, 5584.776608935759, 5590.217369568345, 5601.439856014529, 5604.103343465026, 5632.183333416713, 4019.376996565537, 4060.3503439449546, 4060.9390859136547, 4091.0, 4091.3453847384276, 6045.818625441244, 6061.242344706911, 6063.272407310975, 6072.90890636632, 6074.32729598975, 5833.941660583339, 5844.795432159854, 5850.7074646266665, 5857.47282744555, 5866.0, 5703.044253266587, 5816.592838501264, 5822.835432913519, 5829.5336373090895, 5841.065429531254, 5737.426257374229, 5744.597878148489, 5751.482366587027, 5755.395683453177, 5782.306123265067, 5770.019096753478, 5807.535397168301, 5868.23712917318, 5870.178175055581, 5877.324107727495, 5682.5453963681975, 5713.7428815704225, 5722.141678748055, 5729.169270455677, 5741.655500669973], "value": 4339.093741162201, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.2863415438251, 764.2739397572307, 774.0363247756544, 782.8316911863948, 789.9644515996781, 11646.883531164685, 12328.075394345415, 12711.173773704702, 13172.604821855348, 13197.0, 14197.574072777834, 14736.778948315783, 15355.923220383911, 15395.923020384882, 15430.151341676203, 838.9832203355944, 853.8847255620474, 856.0839901305606, 856.1395797223781, 857.9699710510133, 908.6138391183754, 910.7586489580267, 912.6896855069275, 913.6573784830689, 917.5320586500899, 946.1484663802564, 953.3898305084751, 954.7326748510428, 955.4028732042474, 956.3974695941582, 941.1200527506769, 952.5332587032339, 952.9761755956088, 958.5830163878735, 959.6545243712258, 694.586720901063, 698.0506511144839, 700.6251655364407, 701.0220742064841, 704.3801454719865, 14112.788308175386, 14509.419623215164, 14606.926965365212, 14757.0, 14798.778018329735, 15372.769408458882, 15771.526854194393, 15774.132422716746, 16153.91923040389, 16350.0, 12169.574064907774, 12396.628101156979, 12446.25322480654, 12477.251364918135, 12599.370031498389, 2914.2568644995604, 2926.561015847619, 2938.8824447022093, 2947.425252075846, 2954.4534261161753, 69750.30249697539, 70519.0, 71543.64228178878, 71554.0, 72559.63720181365, 12766.999999999814, 12817.871821281668, 12829.358532073358, 12850.357482125857, 12921.224726516439, 22203.22288719887, 22888.65667014996, 22927.656085158735, 22970.770292296864, 23070.65394019091, 6016.578839481282, 6065.3934606539, 6161.630302181883, 6204.7828326008375, 6227.06594010902, 2975.821450712964, 3039.589655396493, 3047.3905218956297, 3067.049214743392, 3073.1702440340982, 3494.405950988338, 3550.0769799852224, 3604.7837129772297, 3608.747387682837, 3621.402468592705, 725.1624373848214, 727.0, 734.3207533031924, 734.9816254593678, 736.7163641997762, 476.7568540044602, 497.4528019178874, 504.47282589693856, 504.98485045448695, 506.53398873036895, 8700.08649091849, 9109.817803644022, 9857.901420985841, 9986.500674966223, 10558.788824223473, 530.5914445876731, 544.5453046706045, 546.4508169289838, 557.2811073714862, 559.97480113395, 3601.2077342984503, 3607.981960090235, 3612.7471077024356, 3665.890023299305, 3733.607971163043, 59821.0, 60879.69560152171, 62399.6880015597, 63652.36347636557, 63811.36188638147, 50514.0, 50886.23670644943, 52383.73808130935, 53105.2034219487, 53464.73267633637, 45930.54069459329, 46360.7681961588, 46478.0, 47138.0, 47685.0, 10367.637132700622, 10551.155907527533, 10727.463626818784, 11049.779004419706, 11194.44027798623, 25398.873005635593, 25602.87198563995, 25963.05277104187, 26531.734682652925, 27232.0, 41645.37531937084, 42359.0, 42936.63292088489, 43552.0, 43649.56350436582, 13766.793498097337, 13953.441862325393, 14108.506202282872, 14302.355229148365, 14319.0, 14613.0, 14735.189564573622, 14879.181645009628, 15138.0, 15221.6194595136, 14310.856891430953, 14383.280835958369, 14657.853421466076, 14814.925925370304, 14846.480373186887, 12924.806127908278, 13031.218126912416, 13066.085374024107, 13183.14309569875, 13345.66635834112, 13642.86357136416, 13871.375788089359, 14059.22674252926, 14133.081349712236, 14306.713865722835, 10147.391156530632, 10191.898081019392, 10449.268551201647, 10602.522886469973, 10609.575616975235, 10930.72673183145, 11093.50079246452, 11585.88414115848, 11621.535138594361, 11758.70603234926], "value": 6753.972720662921, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 113.0, 112.0, 111.0, 112.0, 112.0, 112.0, 112.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 130.0, 125.0, 169.0, 127.0, 125.0, 124.0, 130.0, 150.0, 125.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 164.0, 163.0, 169.0, 165.0, 168.0, 164.0, 164.0, 165.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 78.0, 109.0, 79.0, 74.0, 76.0, 75.0, 108.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 101.0, 84.0, 83.0, 85.0, 96.0, 83.0, 83.0, 107.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 114.0, 114.0, 115.0, 115.0, 117.0, 114.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 151.0, 150.0, 150.0, 151.0, 150.0, 152.0, 149.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 98.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 56.0, 53.0, 55.0, 56.0, 55.0, 56.0, 57.0, 56.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 56.0, 58.0, 57.0, 57.0, 57.0, 57.0, 56.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 82.0, 82.0, 82.0, 85.0, 83.0, 83.0, 82.0, 92.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 134.0, 144.0, 131.0, 133.0, 133.0, 130.0, 140.0, 176.0, 131.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 193.0, 192.0, 190.0, 198.0, 206.0, 190.0, 188.0, 182.0, 192.0], "value": 191.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 75.0, 78.0, 73.0, 75.0, 72.0, 73.0, 75.0], "value": 74.6, "unit": "score"}]}]} 12:23:49 INFO - Return code: 0 12:23:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:23:49 INFO - # TBPL SUCCESS # 12:23:49 INFO - Running post-action listener: _resource_record_post_action 12:23:49 INFO - [mozharness: 2017-05-10 19:23:49.756794Z] Finished run-tests step (success) 12:23:49 INFO - Running post-run listener: _resource_record_post_run 12:23:49 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 366211072; Read time: 4; Write time: 230524 12:23:49 INFO - TinderboxPrint: CPU usage
13.3% 12:23:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 12:23:49 INFO - TinderboxPrint: I/O write bytes / time
366,211,072 / 230,524 12:23:49 INFO - TinderboxPrint: CPU idle
8,305.3 (86.7%) 12:23:49 INFO - TinderboxPrint: CPU user
1,215.8 (12.7%) 12:23:49 INFO - TinderboxPrint: Swap in / out
0 / 0 12:23:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106725376; Read time: 0; Write time: 92648 12:23:49 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 259485696; Read time: 0; Write time: 137876 12:23:50 INFO - Running post-run listener: _upload_blobber_files 12:23:50 INFO - Blob upload gear active. 12:23:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:23:50 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 12:23:50 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'] 12:23:50 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 12:23:50 INFO - (blobuploader) - INFO - Open directory for files ... 12:23:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:23:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:23:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:23:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:23:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:23:51 INFO - (blobuploader) - INFO - Done attempting. 12:23:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:23:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:23:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:23:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:23:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:23:55 INFO - (blobuploader) - INFO - Done attempting. 12:23:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:23:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:23:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:23:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:23:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:23:56 INFO - (blobuploader) - INFO - Done attempting. 12:23:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:23:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:23:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:23:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:23:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:23:57 INFO - (blobuploader) - INFO - Done attempting. 12:23:57 INFO - (blobuploader) - INFO - Iteration through files over. 12:23:57 INFO - Return code: 0 12:23:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:23:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:23:57 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3aeaf122c32aed4ffa3538c27605f0a0d4da3e43c302e65f6c33f570516071f0bd5ccb8648b430c5e55d37674d1c8829d980ba583014cf19c5e4361b743f3954", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/13366ab5cbbf287e11836c2b4c30465716a6053b08349a983843567b4c91b5a7d389bf654282381e1fabcc4042d37c7e23c8ef22fac1c8155585cdd15500f1fe", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/08ce3a9280dd3f16ef1f8dd09649077b8ce6df802982a5da8c19a14922f9fa76acd0ac9f7ac4049adfa9c170ebd8b2e30b22213a2635a748790cf83839403c12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28bf4feef1920f25582f7071b4a2257111f6018dc58533c404dde391bfd381b094c6f8b6952ff78cff4ef4a75859796601bd71caa52a69121668ad1cfb186fd8"} 12:23:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:23:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:23:57 INFO - Contents: 12:23:57 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3aeaf122c32aed4ffa3538c27605f0a0d4da3e43c302e65f6c33f570516071f0bd5ccb8648b430c5e55d37674d1c8829d980ba583014cf19c5e4361b743f3954", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/13366ab5cbbf287e11836c2b4c30465716a6053b08349a983843567b4c91b5a7d389bf654282381e1fabcc4042d37c7e23c8ef22fac1c8155585cdd15500f1fe", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/08ce3a9280dd3f16ef1f8dd09649077b8ce6df802982a5da8c19a14922f9fa76acd0ac9f7ac4049adfa9c170ebd8b2e30b22213a2635a748790cf83839403c12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28bf4feef1920f25582f7071b4a2257111f6018dc58533c404dde391bfd381b094c6f8b6952ff78cff4ef4a75859796601bd71caa52a69121668ad1cfb186fd8"} 12:23:57 INFO - Running post-run listener: copy_logs_to_upload_dir 12:23:57 INFO - Copying logs to upload dir... 12:23:57 INFO - mkdir: /builds/slave/test/build/upload/logs 12:23:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.805993 ========= master_lag: -0.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-10 12:23:56.793562) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 12:23:56.798075) ========= 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=0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3aeaf122c32aed4ffa3538c27605f0a0d4da3e43c302e65f6c33f570516071f0bd5ccb8648b430c5e55d37674d1c8829d980ba583014cf19c5e4361b743f3954", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/13366ab5cbbf287e11836c2b4c30465716a6053b08349a983843567b4c91b5a7d389bf654282381e1fabcc4042d37c7e23c8ef22fac1c8155585cdd15500f1fe", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/08ce3a9280dd3f16ef1f8dd09649077b8ce6df802982a5da8c19a14922f9fa76acd0ac9f7ac4049adfa9c170ebd8b2e30b22213a2635a748790cf83839403c12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28bf4feef1920f25582f7071b4a2257111f6018dc58533c404dde391bfd381b094c6f8b6952ff78cff4ef4a75859796601bd71caa52a69121668ad1cfb186fd8"} build_url:https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/RzPACUvuQ3ahnxF0JMZTNw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3aeaf122c32aed4ffa3538c27605f0a0d4da3e43c302e65f6c33f570516071f0bd5ccb8648b430c5e55d37674d1c8829d980ba583014cf19c5e4361b743f3954", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/13366ab5cbbf287e11836c2b4c30465716a6053b08349a983843567b4c91b5a7d389bf654282381e1fabcc4042d37c7e23c8ef22fac1c8155585cdd15500f1fe", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/08ce3a9280dd3f16ef1f8dd09649077b8ce6df802982a5da8c19a14922f9fa76acd0ac9f7ac4049adfa9c170ebd8b2e30b22213a2635a748790cf83839403c12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28bf4feef1920f25582f7071b4a2257111f6018dc58533c404dde391bfd381b094c6f8b6952ff78cff4ef4a75859796601bd71caa52a69121668ad1cfb186fd8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 12:23:56.826458) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:23:56.826794) ========= 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=0e2a256762fed810e2f0f810000001b3-1494442980.189943-394224485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:23:56.907101) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 12:23:56.907374) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 12:23:56.907636) ========= ========= Total master_lag: -0.17 =========